"./bisync.test -test.v -test.timeout 1h0m0s -remote TestPremiumizeMe: -verbose" - Starting (try 2/5)
=== RUN TestBisyncRemoteLocal
2025/06/14 02:19:57 NOTICE: remote: TestPremiumizeMe:rclone-test-senacic4jupa
=== RUN TestBisyncRemoteLocal/all_changed
2025/06/14 02:20:37 ERROR : error listing: directory not found
2025/06/14 02:20:37 ERROR : error listing: directory not found
2025/06/14 02:20:37 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_all_changed-qotutem4
2025/06/14 02:21:54 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/all_changed/path1'
2025/06/14 02:21:56 NOTICE: checking path2 Local file system at /tmp/021957ja/all_changed/path2
2025/06/14 02:21:56 NOTICE: [36m(01) :[0m [34mtest all-changed[0m
2025/06/14 02:21:56 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:21:56 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/backupdir
2025/06/14 02:22:10 ERROR : error listing: directory not found
2025/06/14 02:22:10 ERROR : error listing: directory not found
2025/06/14 02:22:10 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_backupdir-qafociq8
2025/06/14 02:23:08 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/backupdir/path1'
2025/06/14 02:23:09 NOTICE: checking path2 Local file system at /tmp/021957ja/backupdir/path2
2025/06/14 02:23:09 NOTICE: [36m(01) :[0m [34mtest backupdir[0m
2025/06/14 02:23:09 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:23:09 NOTICE: [36m(03) :[0m [34mbisync resync backupdir1=/tmp/021957ja/workdir/backupdirs/backupdir1 backupdir2=/tmp/021957ja/workdir/backupdirs/backupdir2[0m
bisync_test.go:934: backupdir test currently only works on local (it uses the workdir)
=== RUN TestBisyncRemoteLocal/basic
2025/06/14 02:23:20 ERROR : error listing: directory not found
2025/06/14 02:23:20 ERROR : error listing: directory not found
2025/06/14 02:23:20 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_basic-calazok8
2025/06/14 02:24:48 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/basic/path1'
2025/06/14 02:24:52 NOTICE: checking path2 Local file system at /tmp/021957ja/basic/path2
2025/06/14 02:24:52 NOTICE: [36m(01) :[0m [34mtest basic[0m
2025/06/14 02:24:52 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:24:52 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/changes
2025/06/14 02:25:00 ERROR : error listing: directory not found
2025/06/14 02:25:00 ERROR : error listing: directory not found
2025/06/14 02:25:00 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_changes-mapowaj6
2025/06/14 02:25:34 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/changes/path1'
2025/06/14 02:25:36 NOTICE: checking path2 Local file system at /tmp/021957ja/changes/path2
2025/06/14 02:25:36 NOTICE: [36m(01) :[0m [34mtest changes[0m
2025/06/14 02:25:36 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:25:36 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/check_access
2025/06/14 02:25:54 ERROR : error listing: directory not found
2025/06/14 02:25:54 ERROR : error listing: directory not found
2025/06/14 02:25:54 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_check_access-xigesoy0
2025/06/14 02:26:32 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/check_access/path1'
2025/06/14 02:26:34 NOTICE: checking path2 Local file system at /tmp/021957ja/check_access/path2
2025/06/14 02:26:34 NOTICE: [36m(01) :[0m [34mtest check-access[0m
2025/06/14 02:26:34 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:26:34 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/check_access_filters
2025/06/14 02:26:53 ERROR : error listing: directory not found
2025/06/14 02:26:53 ERROR : error listing: directory not found
2025/06/14 02:26:53 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_check_access_filters-heyukuz2
2025/06/14 02:29:30 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/check_access_filters/path1'
2025/06/14 02:29:38 NOTICE: checking path2 Local file system at /tmp/021957ja/check_access_filters/path2
2025/06/14 02:29:38 NOTICE: [36m(01) :[0m [34mtest check-access-filters[0m
2025/06/14 02:29:38 NOTICE: [36m(02) :[0m [34mtest EXCLUDE - OTHER TESTS[0m
2025/06/14 02:29:38 NOTICE: [36m(03) :[0m [34mcopy-file /tmp/021957ja/datadir/test_check_access_filters-qelotiq7/exclude-other-filtersfile.txt /tmp/021957ja/workdir/[0m
2025/06/14 02:29:38 NOTICE: [36m(04) :[0m [34mtest resync to get the filters file md5 built.[0m
2025/06/14 02:29:38 NOTICE: [36m(05) :[0m [34mbisync resync filters-file=/tmp/021957ja/workdir/exclude-other-filtersfile.txt[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/check_filename
2025/06/14 02:29:46 ERROR : error listing: directory not found
2025/06/14 02:29:46 ERROR : error listing: directory not found
2025/06/14 02:29:46 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_check_filename-hutiluj7
2025/06/14 02:30:23 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/check_filename/path1'
2025/06/14 02:30:24 NOTICE: checking path2 Local file system at /tmp/021957ja/check_filename/path2
2025/06/14 02:30:25 NOTICE: [36m(01) :[0m [34mtest check-filename[0m
2025/06/14 02:30:25 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:30:25 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/check_sync
2025/06/14 02:30:33 ERROR : error listing: directory not found
2025/06/14 02:30:33 ERROR : error listing: directory not found
2025/06/14 02:30:33 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_check_sync-gurelop4
2025/06/14 02:30:49 ERROR : premiumize.me root 'rclone-test-senacic4jupa/021957ja/check_sync/path1': error reading destination root directory: couldn't list files: 503 Service Unavailable (503):
503 Service Temporarily Unavailable
503 Service Temporarily Unavailable
nginx/1.18.0 (Ubuntu)
bisync_test.go:1943:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1943
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:458
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
Error: Received unexpected error:
couldn't list files: 503 Service Unavailable (503):
503 Service Temporarily Unavailable
503 Service Temporarily Unavailable
nginx/1.18.0 (Ubuntu)
Test: TestBisyncRemoteLocal/check_sync
Messages: setting up path1
2025/06/14 02:33:17 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/check_sync/path1'
2025/06/14 02:33:20 NOTICE: checking path2 Local file system at /tmp/021957ja/check_sync/path2
2025/06/14 02:33:20 NOTICE: [36m(01) :[0m [34mtest check-sync[0m
2025/06/14 02:33:20 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:33:20 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/compare_all
2025/06/14 02:33:40 ERROR : error listing: directory not found
2025/06/14 02:33:40 ERROR : error listing: directory not found
2025/06/14 02:33:40 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_compare_all-torutaq3
2025/06/14 02:34:50 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/compare_all/path1'
2025/06/14 02:34:50 NOTICE: checking path2 Local file system at /tmp/021957ja/compare_all/path2
2025/06/14 02:34:50 NOTICE: [36m(01) :[0m [34mtest changes compare-all[0m
2025/06/14 02:34:50 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:34:50 NOTICE: [36m(03) :[0m [34mbisync resync compare-all[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/concurrent
2025/06/14 02:34:59 ERROR : error listing: directory not found
2025/06/14 02:34:59 ERROR : error listing: directory not found
2025/06/14 02:34:59 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_concurrent-seyoxat7
2025/06/14 02:35:59 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/concurrent/path1'
2025/06/14 02:36:00 NOTICE: checking path2 Local file system at /tmp/021957ja/concurrent/path2
2025/06/14 02:36:00 NOTICE: [36m(01) :[0m [34mtest concurrent[0m
2025/06/14 02:36:00 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:36:00 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/createemptysrcdirs
2025/06/14 02:36:08 ERROR : error listing: directory not found
2025/06/14 02:36:08 ERROR : error listing: directory not found
2025/06/14 02:36:08 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_createemptysrcdirs-xojeric1
2025/06/14 02:36:40 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/createemptysrcdirs/path1'
2025/06/14 02:36:41 NOTICE: checking path2 Local file system at /tmp/021957ja/createemptysrcdirs/path2
2025/06/14 02:36:41 NOTICE: [36m(01) :[0m [34mtest createemptysrcdirs[0m
2025/06/14 02:36:41 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:36:41 NOTICE: [36m(03) :[0m [34mtouch-glob 2001-01-02 /tmp/021957ja/datadir/test_createemptysrcdirs-hewemon8/ placeholder.txt[0m
2025/06/14 02:36:41 NOTICE: [36m(04) :[0m [34mcopy-as /tmp/021957ja/datadir/test_createemptysrcdirs-hewemon8/placeholder.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/createemptysrcdirs/path1/ file1.txt[0m
2025/06/14 02:36:47 NOTICE: [36m(05) :[0m [34mcopy-as /tmp/021957ja/datadir/test_createemptysrcdirs-hewemon8/placeholder.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/createemptysrcdirs/path1/ file1.copy1.txt[0m
2025/06/14 02:36:52 NOTICE: [36m(06) :[0m [34mcopy-as /tmp/021957ja/datadir/test_createemptysrcdirs-hewemon8/placeholder.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/createemptysrcdirs/path1/ file1.copy2.txt[0m
2025/06/14 02:36:58 NOTICE: [36m(07) :[0m [34mcopy-as /tmp/021957ja/datadir/test_createemptysrcdirs-hewemon8/placeholder.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/createemptysrcdirs/path1/ file1.copy3.txt[0m
2025/06/14 02:37:04 NOTICE: [36m(08) :[0m [34mcopy-as /tmp/021957ja/datadir/test_createemptysrcdirs-hewemon8/placeholder.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/createemptysrcdirs/path1/ file1.copy4.txt[0m
2025/06/14 02:37:08 NOTICE: [36m(09) :[0m [34mcopy-as /tmp/021957ja/datadir/test_createemptysrcdirs-hewemon8/placeholder.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/createemptysrcdirs/path1/ file1.copy5.txt[0m
2025/06/14 02:37:13 NOTICE: [36m(10) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/dry_run
2025/06/14 02:37:21 ERROR : error listing: directory not found
2025/06/14 02:37:21 ERROR : error listing: directory not found
2025/06/14 02:37:21 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_dry_run-qenipep7
2025/06/14 02:38:05 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/dry_run/path1'
2025/06/14 02:38:08 NOTICE: checking path2 Local file system at /tmp/021957ja/dry_run/path2
2025/06/14 02:38:08 NOTICE: [36m(01) :[0m [34mtest dry-run[0m
2025/06/14 02:38:08 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:38:08 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/equal
2025/06/14 02:38:15 ERROR : error listing: directory not found
2025/06/14 02:38:15 ERROR : error listing: directory not found
2025/06/14 02:38:15 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_equal-sujomar6
2025/06/14 02:38:30 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/equal/path1'
2025/06/14 02:38:31 NOTICE: checking path2 Local file system at /tmp/021957ja/equal/path2
2025/06/14 02:38:31 NOTICE: [36m(01) :[0m [34mtest equal[0m
2025/06/14 02:38:31 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:38:31 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/ext_paths
2025/06/14 02:38:39 ERROR : error listing: directory not found
2025/06/14 02:38:39 ERROR : error listing: directory not found
2025/06/14 02:38:39 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_ext_paths-rafakir6
2025/06/14 02:40:30 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/ext_paths/path1'
2025/06/14 02:40:37 NOTICE: checking path2 Local file system at /tmp/021957ja/ext_paths/path2
2025/06/14 02:40:37 NOTICE: [36m(01) :[0m [34mtest extended-char-paths[0m
2025/06/14 02:40:37 NOTICE: [36m(02) :[0m [34mfix-names TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/ext_paths/path1/測試Русский{spc}{spc}ěáñ/[0m
2025/06/14 02:41:15 ERROR : premiumize.me root 'rclone-test-senacic4jupa/021957ja/ext_paths/path1/測試Русский ěáñ-rclone-move-datesog3': Server side directory move failed: directory not found
2025/06/14 02:41:25 ERROR : premiumize.me root 'rclone-test-senacic4jupa/021957ja/ext_paths/path1/測試Русский ěáñ-rclone-move-datesog3': error reading source root directory: directory not found
2025/06/14 02:41:25 NOTICE: [36m(03) :[0m [34mfix-names /tmp/021957ja/ext_paths/path2/測試Русский{spc}{spc}ěáñ/[0m
2025/06/14 02:41:25 ERROR : Local file system at /tmp/021957ja/ext_paths/path2/測試Русский ěáñ-rclone-move-dasaxog7: Server side directory move failed: rename /tmp/021957ja/ext_paths/path2/測試Русский ěáñ /tmp/021957ja/ext_paths/path2/測試Русский ěáñ-rclone-move-dasaxog7: no such file or directory
2025/06/14 02:41:25 ERROR : Local file system at /tmp/021957ja/ext_paths/path2/測試Русский ěáñ-rclone-move-dasaxog7: error reading source root directory: directory not found
2025/06/14 02:41:25 NOTICE: [36m(04) :[0m [34mfix-names TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 02:41:35 NOTICE: [36m(05) :[0m [34mfix-names /tmp/021957ja/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 02:41:35 NOTICE: [36m(06) :[0m [34mfix-names TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/ext_paths/path1/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt[0m
2025/06/14 02:41:40 NOTICE: [36m(07) :[0m [34mfix-names /tmp/021957ja/ext_paths/path2/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt[0m
2025/06/14 02:41:40 NOTICE: [36m(08) :[0m [34mfix-names TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/ext_paths/path1/測試_check{spc}file[0m
2025/06/14 02:41:46 NOTICE: [36m(09) :[0m [34mfix-names /tmp/021957ja/ext_paths/path2/測試_check{spc}file[0m
2025/06/14 02:41:46 NOTICE: [36m(10) :[0m [34mfix-names TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 02:41:56 NOTICE: [36m(11) :[0m [34mfix-names /tmp/021957ja/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 02:41:56 NOTICE: [36m(12) :[0m [34mtest resync subdirs with extended chars[0m
2025/06/14 02:41:56 NOTICE: [36m(13) :[0m [34mbisync subdir=測試Русский{spc}{spc}ěáñ resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/extended_filenames
2025/06/14 02:42:05 ERROR : error listing: directory not found
2025/06/14 02:42:05 ERROR : error listing: directory not found
2025/06/14 02:42:05 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_extended_filenames-wazuter9
2025/06/14 02:43:29 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/extended_filenames/path1'
2025/06/14 02:43:30 NOTICE: checking path2 Local file system at /tmp/021957ja/extended_filenames/path2
2025/06/14 02:43:30 NOTICE: [36m(01) :[0m [34mtest extended-filenames[0m
2025/06/14 02:43:30 NOTICE: [36m(02) :[0m [34mfix-names TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/extended_filenames/path1/subdir_with_ࢺ_/[0m
2025/06/14 02:43:30 NOTICE: [36m(03) :[0m [34mfix-names /tmp/021957ja/extended_filenames/path2/subdir_with_ࢺ_/[0m
2025/06/14 02:43:30 NOTICE: [36m(04) :[0m [34mfix-names TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/extended_filenames/path1/subdir_with_ࢺ_/filename_contains_ě_.txt[0m
2025/06/14 02:43:36 NOTICE: [36m(05) :[0m [34mfix-names /tmp/021957ja/extended_filenames/path2/subdir_with_ࢺ_/filename_contains_ě_.txt[0m
2025/06/14 02:43:36 NOTICE: [36m(06) :[0m [34mfix-names TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/extended_filenames/path1/Русский.txt[0m
2025/06/14 02:43:41 NOTICE: [36m(07) :[0m [34mfix-names /tmp/021957ja/extended_filenames/path2/Русский.txt[0m
2025/06/14 02:43:41 NOTICE: [36m(08) :[0m [34mfix-names TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/extended_filenames/path1/file_enconde_mañana_funcionará.txt[0m
2025/06/14 02:43:46 NOTICE: [36m(09) :[0m [34mfix-names /tmp/021957ja/extended_filenames/path2/file_enconde_mañana_funcionará.txt[0m
2025/06/14 02:43:46 NOTICE: [36m(10) :[0m [34mtest initial bisync[0m
2025/06/14 02:43:46 NOTICE: [36m(11) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/filters
2025/06/14 02:43:54 ERROR : error listing: directory not found
2025/06/14 02:43:54 ERROR : error listing: directory not found
2025/06/14 02:43:54 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_filters-xilurag9
2025/06/14 02:44:30 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/filters/path1'
2025/06/14 02:44:31 NOTICE: checking path2 Local file system at /tmp/021957ja/filters/path2
2025/06/14 02:44:31 NOTICE: [36m(01) :[0m [34mtest filters[0m
2025/06/14 02:44:31 NOTICE: [36m(02) :[0m [34mcopy-file /tmp/021957ja/datadir/test_filters-heluwum9/filtersfile.flt /tmp/021957ja/workdir/[0m
2025/06/14 02:44:31 NOTICE: [36m(03) :[0m [34mtest resync to force building of the filters md5 hash[0m
2025/06/14 02:44:31 NOTICE: [36m(04) :[0m [34mbisync filters-file=/tmp/021957ja/workdir/filtersfile.flt resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/filtersfile_checks
2025/06/14 02:44:38 ERROR : error listing: directory not found
2025/06/14 02:44:38 ERROR : error listing: directory not found
2025/06/14 02:44:38 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_filtersfile_checks-wivobux2
2025/06/14 02:44:58 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/filtersfile_checks/path1'
2025/06/14 02:44:59 NOTICE: checking path2 Local file system at /tmp/021957ja/filtersfile_checks/path2
2025/06/14 02:44:59 NOTICE: [36m(01) :[0m [34mtest filtersfile-checks[0m
2025/06/14 02:44:59 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:44:59 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/ignorelistingchecksum
2025/06/14 02:45:08 ERROR : error listing: directory not found
2025/06/14 02:45:08 ERROR : error listing: directory not found
2025/06/14 02:45:08 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_ignorelistingchecksum-cinadag8
2025/06/14 02:45:38 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/ignorelistingchecksum/path1'
2025/06/14 02:45:41 NOTICE: checking path2 Local file system at /tmp/021957ja/ignorelistingchecksum/path2
2025/06/14 02:45:41 NOTICE: [36m(01) :[0m [34mtest basic[0m
2025/06/14 02:45:41 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:45:41 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/max_delete_path1
2025/06/14 02:45:49 ERROR : error listing: directory not found
2025/06/14 02:45:49 ERROR : error listing: directory not found
2025/06/14 02:45:49 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_max_delete_path1-nutebeh9
2025/06/14 02:46:20 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/max_delete_path1/path1'
2025/06/14 02:46:22 NOTICE: checking path2 Local file system at /tmp/021957ja/max_delete_path1/path2
2025/06/14 02:46:22 NOTICE: [36m(01) :[0m [34mtest max-delete-path1[0m
2025/06/14 02:46:22 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:46:22 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/max_delete_path2_force
2025/06/14 02:46:29 ERROR : error listing: directory not found
2025/06/14 02:46:29 ERROR : error listing: directory not found
2025/06/14 02:46:29 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_max_delete_path2_force-bivofuj2
2025/06/14 02:47:03 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/max_delete_path2_force/path1'
2025/06/14 02:47:03 NOTICE: checking path2 Local file system at /tmp/021957ja/max_delete_path2_force/path2
2025/06/14 02:47:03 NOTICE: [36m(01) :[0m [34mtest max-delete-path2-force[0m
2025/06/14 02:47:03 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:47:03 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/nomodtime
2025/06/14 02:47:10 ERROR : error listing: directory not found
2025/06/14 02:47:10 ERROR : error listing: directory not found
2025/06/14 02:47:10 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_nomodtime-xicuvum0
2025/06/14 02:47:44 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/nomodtime/path1'
2025/06/14 02:47:44 NOTICE: checking path2 Local file system at /tmp/021957ja/nomodtime/path2
2025/06/14 02:47:44 NOTICE: [36m(01) :[0m [34mtest changes[0m
2025/06/14 02:47:44 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:47:44 NOTICE: [36m(03) :[0m [34mbisync resync nomodtime[0m
2025/06/14 02:47:47 NOTICE: Local file system at /tmp/021957ja/nomodtime/path2: [33mwill use md5 for same-side diffs on Path2 only[0m
2025/06/14 02:47:47 INFO : Bisyncing with Comparison Settings:
{
"Modtime": false,
"Size": true,
"Checksum": true,
"HashType1": 0,
"HashType2": 1,
"NoSlowHash": false,
"SlowHashSyncOnly": false,
"SlowHashDetected": true,
"DownloadHash": true
}
2025/06/14 02:47:47 INFO : Synching Path1 "TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/" with Path2 "/tmp/021957ja/nomodtime/path2/"
2025/06/14 02:47:47 INFO : Copying Path2 files to Path1
2025/06/14 02:47:47 INFO : - [34mPath2[0m [35mResync is copying files to[0m - [36mPath1[0m
2025/06/14 02:47:48 INFO : TestPremiumizeMe: [2mDownloading hashes...[0m
2025/06/14 02:47:52 INFO : - [36mPath1[0m [35mResync is copying files to[0m - [36mPath2[0m
2025/06/14 02:47:53 INFO : Resync updating listings
2025/06/14 02:47:53 INFO : Validating listings for Path1 "TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/" vs Path2 "/tmp/021957ja/nomodtime/path2/"
2025/06/14 02:47:53 INFO : [32mBisync successful[0m
2025/06/14 02:47:53 NOTICE: [36m(04) :[0m [34mtest make modifications on both paths[0m
2025/06/14 02:47:53 NOTICE: [36m(05) :[0m [34mtest new on path2 - file10[0m
2025/06/14 02:47:53 NOTICE: [36m(06) :[0m [34mcopy-file /tmp/021957ja/datadir/test_nomodtime-giwizap7/file10.txt /tmp/021957ja/nomodtime/path2/[0m
2025/06/14 02:47:53 NOTICE: [36m(07) :[0m [34mtest changed on path2 - file1[0m
2025/06/14 02:47:53 NOTICE: [36m(08) :[0m [34mcopy-file /tmp/021957ja/datadir/test_nomodtime-giwizap7/file1.txt /tmp/021957ja/nomodtime/path2/[0m
2025/06/14 02:47:53 NOTICE: [36m(09) :[0m [34mtest new on path1 - file11[0m
2025/06/14 02:47:53 NOTICE: [36m(10) :[0m [34mcopy-file /tmp/021957ja/datadir/test_nomodtime-giwizap7/file11.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/[0m
2025/06/14 02:47:58 NOTICE: [36m(11) :[0m [34mtest changed on path1 - file2[0m
2025/06/14 02:47:58 NOTICE: [36m(12) :[0m [34mcopy-file /tmp/021957ja/datadir/test_nomodtime-giwizap7/file2.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/[0m
2025/06/14 02:48:06 NOTICE: [36m(13) :[0m [34mtest deleted on path2 - file3[0m
2025/06/14 02:48:06 NOTICE: [36m(14) :[0m [34mdelete-file /tmp/021957ja/nomodtime/path2/file3.txt[0m
2025/06/14 02:48:06 NOTICE: [36m(15) :[0m [34mtest deleted on path1 - file4[0m
2025/06/14 02:48:06 NOTICE: [36m(16) :[0m [34mdelete-file TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/file4.txt[0m
2025/06/14 02:48:12 NOTICE: [36m(17) :[0m [34mtest deleted on both paths - file8[0m
2025/06/14 02:48:12 NOTICE: [36m(18) :[0m [34mdelete-file TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/file8.txt[0m
2025/06/14 02:48:15 NOTICE: [36m(19) :[0m [34mdelete-file /tmp/021957ja/nomodtime/path2/file8.txt[0m
2025/06/14 02:48:15 NOTICE: [36m(20) :[0m [34mtest changed on both paths - file5 (file5R, file5L)[0m
2025/06/14 02:48:15 NOTICE: [36m(21) :[0m [34mcopy-as /tmp/021957ja/datadir/test_nomodtime-giwizap7/file5R.txt /tmp/021957ja/nomodtime/path2/ file5.txt[0m
2025/06/14 02:48:15 NOTICE: [36m(22) :[0m [34mcopy-as /tmp/021957ja/datadir/test_nomodtime-giwizap7/file5L.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/ file5.txt[0m
2025/06/14 02:48:23 NOTICE: [36m(23) :[0m [34mtest changed on path2 and deleted on path1 - file6[0m
2025/06/14 02:48:23 NOTICE: [36m(24) :[0m [34mcopy-file /tmp/021957ja/datadir/test_nomodtime-giwizap7/file6.txt /tmp/021957ja/nomodtime/path2/[0m
2025/06/14 02:48:23 NOTICE: [36m(25) :[0m [34mdelete-file TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/file6.txt[0m
2025/06/14 02:48:26 NOTICE: [36m(26) :[0m [34mtest changed on path1 and deleted on path2 - file7[0m
2025/06/14 02:48:26 NOTICE: [36m(27) :[0m [34mcopy-file /tmp/021957ja/datadir/test_nomodtime-giwizap7/file7.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/[0m
2025/06/14 02:48:34 NOTICE: [36m(28) :[0m [34mdelete-file /tmp/021957ja/nomodtime/path2/file7.txt[0m
2025/06/14 02:48:34 NOTICE: [36m(29) :[0m [34mtest bisync run[0m
2025/06/14 02:48:34 NOTICE: [36m(30) :[0m [34mbisync nomodtime[0m
2025/06/14 02:48:42 NOTICE: Local file system at /tmp/021957ja/nomodtime/path2: [33mwill use md5 for same-side diffs on Path2 only[0m
2025/06/14 02:48:42 INFO : Bisyncing with Comparison Settings:
{
"Modtime": false,
"Size": true,
"Checksum": true,
"HashType1": 0,
"HashType2": 1,
"NoSlowHash": false,
"SlowHashSyncOnly": false,
"SlowHashDetected": true,
"DownloadHash": true
}
2025/06/14 02:48:42 INFO : Synching Path1 "TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/" with Path2 "/tmp/021957ja/nomodtime/path2/"
2025/06/14 02:48:42 INFO : Building Path1 and Path2 listings
2025/06/14 02:48:43 INFO : TestPremiumizeMe: [2mDownloading hashes...[0m
2025/06/14 02:48:45 INFO : Path1 checking for diffs
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile2.txt[0m
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[31mFile was deleted[0m[0m - [36mfile4.txt[0m
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile5.txt[0m
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[31mFile was deleted[0m[0m - [36mfile6.txt[0m
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile7.txt[0m
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[31mFile was deleted[0m[0m - [36mfile8.txt[0m
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[32mFile is new[0m[0m - [36mfile11.txt[0m
2025/06/14 02:48:45 INFO : Path1: 7 changes: [32m 1 new[0m, [33m 3 modified[0m, [31m 3 deleted[0m
2025/06/14 02:48:45 INFO : ([33mModified[0m: [36m 3 larger[0m, [34m 0 smaller[0m, [36m 3 hash differs[0m)
2025/06/14 02:48:45 INFO : Path2 checking for diffs
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile1.txt[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[31mFile was deleted[0m[0m - [36mfile3.txt[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile5.txt[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile6.txt[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[31mFile was deleted[0m[0m - [36mfile7.txt[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[31mFile was deleted[0m[0m - [36mfile8.txt[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[32mFile is new[0m[0m - [36mfile10.txt[0m
2025/06/14 02:48:45 INFO : Path2: 7 changes: [32m 1 new[0m, [33m 3 modified[0m, [31m 3 deleted[0m
2025/06/14 02:48:45 INFO : ([33mModified[0m: [36m 3 larger[0m, [34m 0 smaller[0m, [36m 3 hash differs[0m)
2025/06/14 02:48:45 INFO : Applying changes
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36m/tmp/021957ja/nomodtime/path2/file11.txt[0m
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36m/tmp/021957ja/nomodtime/path2/file2.txt[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[31mQueue delete[0m[0m - [36m/tmp/021957ja/nomodtime/path2/file4.txt[0m
2025/06/14 02:48:45 NOTICE: - [34mWARNING[0m [35mNew or changed in both paths[0m - [36mfile5.txt[0m
2025/06/14 02:48:45 NOTICE: - [36mPath1[0m [35mRenaming Path1 copy[0m - [36mTestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/file5.txt.conflict1[0m
2025/06/14 02:48:45 INFO : file5.txt: Moved (server-side) to: file5.txt.conflict1
2025/06/14 02:48:45 NOTICE: - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36m/tmp/021957ja/nomodtime/path2/file5.txt.conflict1[0m
2025/06/14 02:48:45 NOTICE: - [34mPath2[0m [35mRenaming Path2 copy[0m - [36m/tmp/021957ja/nomodtime/path2/file5.txt.conflict2[0m
2025/06/14 02:48:45 INFO : file5.txt: Moved (server-side) to: file5.txt.conflict2
2025/06/14 02:48:45 NOTICE: - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36mTestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/file5.txt.conflict2[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36mTestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/file6.txt[0m
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36m/tmp/021957ja/nomodtime/path2/file7.txt[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36mTestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/file1.txt[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36mTestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/file10.txt[0m
2025/06/14 02:48:45 INFO : - [36mPath1[0m [35m[31mQueue delete[0m[0m - [36mTestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/file3.txt[0m
2025/06/14 02:48:45 INFO : - [34mPath2[0m [35mDo queued copies to[0m - [36mPath1[0m
2025/06/14 02:48:57 INFO : file10.txt: Copied (new)
2025/06/14 02:48:57 INFO : file1.txt: Copied (replaced existing)
2025/06/14 02:48:59 INFO : file5.txt.conflict2: Copied (new)
2025/06/14 02:48:59 INFO : file6.txt: Copied (new)
2025/06/14 02:49:00 INFO : file3.txt: Deleted
2025/06/14 02:49:00 INFO : - [36mPath1[0m [35mDo queued copies to[0m - [36mPath2[0m
2025/06/14 02:49:02 INFO : file11.txt: Copied (new)
2025/06/14 02:49:03 INFO : file5.txt.conflict1: Copied (new)
2025/06/14 02:49:03 INFO : file7.txt: Copied (new)
2025/06/14 02:49:04 INFO : file2.txt: Copied (replaced existing)
2025/06/14 02:49:04 INFO : file4.txt: Deleted
2025/06/14 02:49:04 INFO : Updating listings
2025/06/14 02:49:04 INFO : Validating listings for Path1 "TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/nomodtime/path1/" vs Path2 "/tmp/021957ja/nomodtime/path2/"
2025/06/14 02:49:04 INFO : [32mBisync successful[0m
bisync_test.go:560: [32mTEST nomodtime PASSED[0m
=== RUN TestBisyncRemoteLocal/normalization
2025/06/14 02:49:10 ERROR : error listing: directory not found
2025/06/14 02:49:10 ERROR : error listing: directory not found
2025/06/14 02:49:10 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_normalization-fetexij4
2025/06/14 02:49:32 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/normalization/path1'
2025/06/14 02:49:34 NOTICE: checking path2 Local file system at /tmp/021957ja/normalization/path2
2025/06/14 02:49:34 NOTICE: [36m(01) :[0m [34mtest normalization[0m
2025/06/14 02:49:34 NOTICE: [36m(02) :[0m [34mtouch-copy 2001-01-02 /tmp/021957ja/datadir/test_normalization-bufayef4/file1.txt /tmp/021957ja/normalization/path2/[0m
2025/06/14 02:49:34 NOTICE: [36m(03) :[0m [34mtest initial bisync[0m
2025/06/14 02:49:34 NOTICE: [36m(04) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/rclone_args
2025/06/14 02:49:43 ERROR : error listing: directory not found
2025/06/14 02:49:43 ERROR : error listing: directory not found
2025/06/14 02:49:43 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_rclone_args-qifocih9
2025/06/14 02:50:04 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/rclone_args/path1'
2025/06/14 02:50:06 NOTICE: checking path2 Local file system at /tmp/021957ja/rclone_args/path2
2025/06/14 02:50:06 NOTICE: [36m(01) :[0m [34mtest rclone-args[0m
2025/06/14 02:50:06 NOTICE: [36m(02) :[0m [34mtouch-glob 2001-01-02 /tmp/021957ja/datadir/test_rclone_args-jopahuv3/ *[0m
2025/06/14 02:50:06 NOTICE: [36m(03) :[0m [34mtest initial bisync[0m
2025/06/14 02:50:06 NOTICE: [36m(04) :[0m [34mbisync resync checksum[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/resolve
2025/06/14 02:50:14 ERROR : error listing: directory not found
2025/06/14 02:50:14 ERROR : error listing: directory not found
2025/06/14 02:50:14 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_resolve-vekosaq0
2025/06/14 02:50:30 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/resolve/path1'
2025/06/14 02:50:30 NOTICE: checking path2 Local file system at /tmp/021957ja/resolve/path2
2025/06/14 02:50:30 NOTICE: [36m(01) :[0m [34mtest resolve[0m
2025/06/14 02:50:30 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:50:30 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/resync
2025/06/14 02:50:37 ERROR : error listing: directory not found
2025/06/14 02:50:37 ERROR : error listing: directory not found
2025/06/14 02:50:37 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_resync-pafeqel1
2025/06/14 02:51:26 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/resync/path1'
2025/06/14 02:51:27 NOTICE: checking path2 Local file system at /tmp/021957ja/resync/path2
2025/06/14 02:51:27 NOTICE: [36m(01) :[0m [34mtest resync[0m
2025/06/14 02:51:27 NOTICE: [36m(02) :[0m [34mtest 1. resync with empty path1, resulting in copying all content from path2.[0m
2025/06/14 02:51:27 NOTICE: [36m(03) :[0m [34mpurge-children TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/resync/path1/[0m
2025/06/14 02:51:29 NOTICE: [36m(04) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/resync_modes
2025/06/14 02:51:29 ERROR : error listing: directory not found
2025/06/14 02:51:29 ERROR : error listing: directory not found
2025/06/14 02:51:29 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_resync_modes-nelitip9
2025/06/14 02:51:38 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/resync_modes/path1'
2025/06/14 02:51:40 NOTICE: checking path2 Local file system at /tmp/021957ja/resync_modes/path2
2025/06/14 02:51:40 NOTICE: [36m(01) :[0m [34mtest resync-mode[0m
2025/06/14 02:51:40 NOTICE: [36m(02) :[0m [34mtest changed on both paths and NOT identical - file1 (file1R, file1L)[0m
2025/06/14 02:51:40 NOTICE: [36m(03) :[0m [34mtouch-glob 2001-01-02 /tmp/021957ja/datadir/test_resync_modes-xepabin4/ file1R.txt[0m
2025/06/14 02:51:40 NOTICE: [36m(04) :[0m [34mcopy-as /tmp/021957ja/datadir/test_resync_modes-xepabin4/file1R.txt /tmp/021957ja/resync_modes/path2/ file1.txt[0m
2025/06/14 02:51:40 NOTICE: [36m(05) :[0m [34mtouch-glob 2001-03-04 /tmp/021957ja/datadir/test_resync_modes-xepabin4/ file1L.txt[0m
2025/06/14 02:51:40 NOTICE: [36m(06) :[0m [34mcopy-as /tmp/021957ja/datadir/test_resync_modes-xepabin4/file1L.txt TestPremiumizeMe:rclone-test-senacic4jupa/021957ja/resync_modes/path1/ file1.txt[0m
2025/06/14 02:51:48 NOTICE: [36m(07) :[0m [34mtest bisync run with --resync-mode=newer[0m
2025/06/14 02:51:48 NOTICE: [36m(08) :[0m [34mbisync resync resync-mode=newer[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/rmdirs
2025/06/14 02:51:58 ERROR : error listing: directory not found
2025/06/14 02:51:58 ERROR : error listing: directory not found
2025/06/14 02:51:58 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_rmdirs-bewizaf8
2025/06/14 02:52:28 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/rmdirs/path1'
2025/06/14 02:52:30 NOTICE: checking path2 Local file system at /tmp/021957ja/rmdirs/path2
2025/06/14 02:52:30 NOTICE: [36m(01) :[0m [34mtest rmdirs[0m
2025/06/14 02:52:30 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:52:30 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteLocal/volatile
2025/06/14 02:52:37 ERROR : error listing: directory not found
2025/06/14 02:52:37 ERROR : error listing: directory not found
2025/06/14 02:52:37 NOTICE: checking initFs Local file system at /tmp/021957ja/initdir/test_volatile-nilicev5
2025/06/14 02:53:09 NOTICE: checking Path1 premiumize.me root 'rclone-test-senacic4jupa/021957ja/volatile/path1'
2025/06/14 02:53:10 NOTICE: checking path2 Local file system at /tmp/021957ja/volatile/path2
2025/06/14 02:53:10 NOTICE: [36m(01) :[0m [34mtest volatile[0m
2025/06/14 02:53:10 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:53:10 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:937: skipping 'volatile' test on non-local as it requires uploading 100 files
--- FAIL: TestBisyncRemoteLocal (1997.42s)
--- SKIP: TestBisyncRemoteLocal/all_changed (119.10s)
--- SKIP: TestBisyncRemoteLocal/backupdir (73.09s)
--- SKIP: TestBisyncRemoteLocal/basic (102.18s)
--- SKIP: TestBisyncRemoteLocal/changes (44.00s)
--- SKIP: TestBisyncRemoteLocal/check_access (58.52s)
--- SKIP: TestBisyncRemoteLocal/check_access_filters (184.23s)
--- SKIP: TestBisyncRemoteLocal/check_filename (46.19s)
--- FAIL: TestBisyncRemoteLocal/check_sync (175.41s)
--- SKIP: TestBisyncRemoteLocal/compare_all (90.51s)
--- SKIP: TestBisyncRemoteLocal/concurrent (69.87s)
--- SKIP: TestBisyncRemoteLocal/createemptysrcdirs (72.77s)
--- SKIP: TestBisyncRemoteLocal/dry_run (54.54s)
--- SKIP: TestBisyncRemoteLocal/equal (23.27s)
--- SKIP: TestBisyncRemoteLocal/ext_paths (205.24s)
--- SKIP: TestBisyncRemoteLocal/extended_filenames (110.19s)
--- SKIP: TestBisyncRemoteLocal/filters (45.06s)
--- SKIP: TestBisyncRemoteLocal/filtersfile_checks (28.04s)
--- SKIP: TestBisyncRemoteLocal/ignorelistingchecksum (41.13s)
--- SKIP: TestBisyncRemoteLocal/max_delete_path1 (41.03s)
--- SKIP: TestBisyncRemoteLocal/max_delete_path2_force (41.71s)
--- PASS: TestBisyncRemoteLocal/nomodtime (120.32s)
--- SKIP: TestBisyncRemoteLocal/normalization (30.55s)
--- SKIP: TestBisyncRemoteLocal/rclone_args (32.20s)
--- SKIP: TestBisyncRemoteLocal/resolve (23.69s)
--- SKIP: TestBisyncRemoteLocal/resync (58.47s)
--- SKIP: TestBisyncRemoteLocal/resync_modes (19.95s)
--- SKIP: TestBisyncRemoteLocal/rmdirs (41.30s)
--- SKIP: TestBisyncRemoteLocal/volatile (40.68s)
=== RUN TestBisyncLocalRemote
2025/06/14 02:53:14 NOTICE: remote: TestPremiumizeMe:rclone-test-fezerof8gera
=== RUN TestBisyncLocalRemote/all_changed
2025/06/14 02:53:29 ERROR : error listing: directory not found
2025/06/14 02:53:30 ERROR : error listing: directory not found
2025/06/14 02:53:30 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_all_changed-tipejog9
2025/06/14 02:53:30 NOTICE: checking Path1 Local file system at /tmp/025314qe/all_changed/path1
2025/06/14 02:54:02 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/all_changed/path2'
2025/06/14 02:54:03 NOTICE: [36m(01) :[0m [34mtest all-changed[0m
2025/06/14 02:54:03 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:54:03 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/backupdir
2025/06/14 02:54:11 ERROR : error listing: directory not found
2025/06/14 02:54:12 ERROR : error listing: directory not found
2025/06/14 02:54:12 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_backupdir-bufemab5
2025/06/14 02:54:12 NOTICE: checking Path1 Local file system at /tmp/025314qe/backupdir/path1
2025/06/14 02:54:43 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/backupdir/path2'
2025/06/14 02:54:44 NOTICE: [36m(01) :[0m [34mtest backupdir[0m
2025/06/14 02:54:44 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:54:44 NOTICE: [36m(03) :[0m [34mbisync resync backupdir1=/tmp/025314qe/workdir/backupdirs/backupdir1 backupdir2=/tmp/025314qe/workdir/backupdirs/backupdir2[0m
bisync_test.go:934: backupdir test currently only works on local (it uses the workdir)
=== RUN TestBisyncLocalRemote/basic
2025/06/14 02:54:52 ERROR : error listing: directory not found
2025/06/14 02:54:52 ERROR : error listing: directory not found
2025/06/14 02:54:52 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_basic-pejunaj0
2025/06/14 02:54:52 NOTICE: checking Path1 Local file system at /tmp/025314qe/basic/path1
2025/06/14 02:55:24 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/basic/path2'
2025/06/14 02:55:25 NOTICE: [36m(01) :[0m [34mtest basic[0m
2025/06/14 02:55:25 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:55:25 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/changes
2025/06/14 02:55:32 ERROR : error listing: directory not found
2025/06/14 02:55:33 ERROR : error listing: directory not found
2025/06/14 02:55:33 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_changes-qeyahom2
2025/06/14 02:55:33 NOTICE: checking Path1 Local file system at /tmp/025314qe/changes/path1
2025/06/14 02:56:05 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/changes/path2'
2025/06/14 02:56:06 NOTICE: [36m(01) :[0m [34mtest changes[0m
2025/06/14 02:56:06 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:56:06 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/check_access
2025/06/14 02:56:13 ERROR : error listing: directory not found
2025/06/14 02:56:14 ERROR : error listing: directory not found
2025/06/14 02:56:14 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_check_access-xedupig9
2025/06/14 02:56:14 NOTICE: checking Path1 Local file system at /tmp/025314qe/check_access/path1
2025/06/14 02:56:42 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/check_access/path2'
2025/06/14 02:56:45 NOTICE: [36m(01) :[0m [34mtest check-access[0m
2025/06/14 02:56:45 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:56:45 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/check_access_filters
2025/06/14 02:56:52 ERROR : error listing: directory not found
2025/06/14 02:56:53 ERROR : error listing: directory not found
2025/06/14 02:56:53 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_check_access_filters-muyaxev0
2025/06/14 02:56:53 NOTICE: checking Path1 Local file system at /tmp/025314qe/check_access_filters/path1
2025/06/14 02:58:08 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/check_access_filters/path2'
2025/06/14 02:58:17 NOTICE: [36m(01) :[0m [34mtest check-access-filters[0m
2025/06/14 02:58:17 NOTICE: [36m(02) :[0m [34mtest EXCLUDE - OTHER TESTS[0m
2025/06/14 02:58:17 NOTICE: [36m(03) :[0m [34mcopy-file /tmp/025314qe/datadir/test_check_access_filters-favuwax7/exclude-other-filtersfile.txt /tmp/025314qe/workdir/[0m
2025/06/14 02:58:17 NOTICE: [36m(04) :[0m [34mtest resync to get the filters file md5 built.[0m
2025/06/14 02:58:17 NOTICE: [36m(05) :[0m [34mbisync resync filters-file=/tmp/025314qe/workdir/exclude-other-filtersfile.txt[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/check_filename
2025/06/14 02:58:24 ERROR : error listing: directory not found
2025/06/14 02:58:25 ERROR : error listing: directory not found
2025/06/14 02:58:25 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_check_filename-behusah9
2025/06/14 02:58:25 NOTICE: checking Path1 Local file system at /tmp/025314qe/check_filename/path1
2025/06/14 02:58:52 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/check_filename/path2'
2025/06/14 02:58:55 NOTICE: [36m(01) :[0m [34mtest check-filename[0m
2025/06/14 02:58:55 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:58:55 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/check_sync
2025/06/14 02:59:01 ERROR : error listing: directory not found
2025/06/14 02:59:03 ERROR : error listing: directory not found
2025/06/14 02:59:03 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_check_sync-sosiriq0
2025/06/14 02:59:03 NOTICE: checking Path1 Local file system at /tmp/025314qe/check_sync/path1
2025/06/14 02:59:34 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/check_sync/path2'
2025/06/14 02:59:35 NOTICE: [36m(01) :[0m [34mtest check-sync[0m
2025/06/14 02:59:35 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:59:35 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/compare_all
2025/06/14 02:59:43 ERROR : error listing: directory not found
2025/06/14 02:59:44 ERROR : error listing: directory not found
2025/06/14 02:59:44 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_compare_all-lapoqad0
2025/06/14 02:59:44 NOTICE: checking Path1 Local file system at /tmp/025314qe/compare_all/path1
2025/06/14 03:00:15 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/compare_all/path2'
2025/06/14 03:00:16 NOTICE: [36m(01) :[0m [34mtest changes compare-all[0m
2025/06/14 03:00:16 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:00:16 NOTICE: [36m(03) :[0m [34mbisync resync compare-all[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/concurrent
2025/06/14 03:00:23 ERROR : error listing: directory not found
2025/06/14 03:00:24 ERROR : error listing: directory not found
2025/06/14 03:00:24 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_concurrent-baticah9
2025/06/14 03:00:24 NOTICE: checking Path1 Local file system at /tmp/025314qe/concurrent/path1
2025/06/14 03:00:56 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/concurrent/path2'
2025/06/14 03:00:58 NOTICE: [36m(01) :[0m [34mtest concurrent[0m
2025/06/14 03:00:58 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:00:58 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/createemptysrcdirs
2025/06/14 03:01:05 ERROR : error listing: directory not found
2025/06/14 03:01:06 ERROR : error listing: directory not found
2025/06/14 03:01:06 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_createemptysrcdirs-zucidoy7
2025/06/14 03:01:06 NOTICE: checking Path1 Local file system at /tmp/025314qe/createemptysrcdirs/path1
2025/06/14 03:01:32 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/createemptysrcdirs/path2'
2025/06/14 03:01:32 NOTICE: [36m(01) :[0m [34mtest createemptysrcdirs[0m
2025/06/14 03:01:32 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:01:32 NOTICE: [36m(03) :[0m [34mtouch-glob 2001-01-02 /tmp/025314qe/datadir/test_createemptysrcdirs-sesetuz8/ placeholder.txt[0m
2025/06/14 03:01:32 NOTICE: [36m(04) :[0m [34mcopy-as /tmp/025314qe/datadir/test_createemptysrcdirs-sesetuz8/placeholder.txt /tmp/025314qe/createemptysrcdirs/path1/ file1.txt[0m
2025/06/14 03:01:32 NOTICE: [36m(05) :[0m [34mcopy-as /tmp/025314qe/datadir/test_createemptysrcdirs-sesetuz8/placeholder.txt /tmp/025314qe/createemptysrcdirs/path1/ file1.copy1.txt[0m
2025/06/14 03:01:32 NOTICE: [36m(06) :[0m [34mcopy-as /tmp/025314qe/datadir/test_createemptysrcdirs-sesetuz8/placeholder.txt /tmp/025314qe/createemptysrcdirs/path1/ file1.copy2.txt[0m
2025/06/14 03:01:32 NOTICE: [36m(07) :[0m [34mcopy-as /tmp/025314qe/datadir/test_createemptysrcdirs-sesetuz8/placeholder.txt /tmp/025314qe/createemptysrcdirs/path1/ file1.copy3.txt[0m
2025/06/14 03:01:32 NOTICE: [36m(08) :[0m [34mcopy-as /tmp/025314qe/datadir/test_createemptysrcdirs-sesetuz8/placeholder.txt /tmp/025314qe/createemptysrcdirs/path1/ file1.copy4.txt[0m
2025/06/14 03:01:32 NOTICE: [36m(09) :[0m [34mcopy-as /tmp/025314qe/datadir/test_createemptysrcdirs-sesetuz8/placeholder.txt /tmp/025314qe/createemptysrcdirs/path1/ file1.copy5.txt[0m
2025/06/14 03:01:32 NOTICE: [36m(10) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/dry_run
2025/06/14 03:01:39 ERROR : error listing: directory not found
2025/06/14 03:01:40 ERROR : error listing: directory not found
2025/06/14 03:01:40 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_dry_run-batifab6
2025/06/14 03:01:40 NOTICE: checking Path1 Local file system at /tmp/025314qe/dry_run/path1
2025/06/14 03:02:09 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/dry_run/path2'
2025/06/14 03:02:10 NOTICE: [36m(01) :[0m [34mtest dry-run[0m
2025/06/14 03:02:10 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:02:10 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/equal
2025/06/14 03:02:19 ERROR : error listing: directory not found
2025/06/14 03:02:20 ERROR : error listing: directory not found
2025/06/14 03:02:20 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_equal-raviveh8
2025/06/14 03:02:20 NOTICE: checking Path1 Local file system at /tmp/025314qe/equal/path1
2025/06/14 03:02:32 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/equal/path2'
2025/06/14 03:02:33 NOTICE: [36m(01) :[0m [34mtest equal[0m
2025/06/14 03:02:33 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:02:33 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/ext_paths
2025/06/14 03:02:40 ERROR : error listing: directory not found
2025/06/14 03:02:41 ERROR : error listing: directory not found
2025/06/14 03:02:41 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_ext_paths-hinefos8
2025/06/14 03:02:41 NOTICE: checking Path1 Local file system at /tmp/025314qe/ext_paths/path1
2025/06/14 03:03:19 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/ext_paths/path2'
2025/06/14 03:03:20 NOTICE: [36m(01) :[0m [34mtest extended-char-paths[0m
2025/06/14 03:03:20 NOTICE: [36m(02) :[0m [34mfix-names /tmp/025314qe/ext_paths/path1/測試Русский{spc}{spc}ěáñ/[0m
2025/06/14 03:03:20 ERROR : Local file system at /tmp/025314qe/ext_paths/path1/測試Русский ěáñ-rclone-move-hekoyiz3: Server side directory move failed: rename /tmp/025314qe/ext_paths/path1/測試Русский ěáñ /tmp/025314qe/ext_paths/path1/測試Русский ěáñ-rclone-move-hekoyiz3: no such file or directory
2025/06/14 03:03:20 ERROR : Local file system at /tmp/025314qe/ext_paths/path1/測試Русский ěáñ-rclone-move-hekoyiz3: error reading source root directory: directory not found
2025/06/14 03:03:20 NOTICE: [36m(03) :[0m [34mfix-names TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/ext_paths/path2/測試Русский{spc}{spc}ěáñ/[0m
2025/06/14 03:03:43 ERROR : premiumize.me root 'rclone-test-fezerof8gera/025314qe/ext_paths/path2/測試Русский ěáñ-rclone-move-curiyoh5': Server side directory move failed: directory not found
2025/06/14 03:03:51 ERROR : premiumize.me root 'rclone-test-fezerof8gera/025314qe/ext_paths/path2/測試Русский ěáñ-rclone-move-curiyoh5': error reading source root directory: directory not found
2025/06/14 03:03:51 NOTICE: [36m(04) :[0m [34mfix-names /tmp/025314qe/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 03:03:51 NOTICE: [36m(05) :[0m [34mfix-names TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 03:03:59 NOTICE: [36m(06) :[0m [34mfix-names /tmp/025314qe/ext_paths/path1/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt[0m
2025/06/14 03:03:59 NOTICE: [36m(07) :[0m [34mfix-names TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/ext_paths/path2/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt[0m
2025/06/14 03:04:05 NOTICE: [36m(08) :[0m [34mfix-names /tmp/025314qe/ext_paths/path1/測試_check{spc}file[0m
2025/06/14 03:04:05 NOTICE: [36m(09) :[0m [34mfix-names TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/ext_paths/path2/測試_check{spc}file[0m
2025/06/14 03:04:09 NOTICE: [36m(10) :[0m [34mfix-names /tmp/025314qe/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 03:04:09 NOTICE: [36m(11) :[0m [34mfix-names TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 03:04:15 NOTICE: [36m(12) :[0m [34mtest resync subdirs with extended chars[0m
2025/06/14 03:04:15 NOTICE: [36m(13) :[0m [34mbisync subdir=測試Русский{spc}{spc}ěáñ resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/extended_filenames
2025/06/14 03:04:23 ERROR : error listing: directory not found
2025/06/14 03:04:23 ERROR : error listing: directory not found
2025/06/14 03:04:23 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_extended_filenames-foqurit7
2025/06/14 03:04:23 NOTICE: checking Path1 Local file system at /tmp/025314qe/extended_filenames/path1
2025/06/14 03:04:59 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/extended_filenames/path2'
2025/06/14 03:05:01 NOTICE: [36m(01) :[0m [34mtest extended-filenames[0m
2025/06/14 03:05:01 NOTICE: [36m(02) :[0m [34mfix-names /tmp/025314qe/extended_filenames/path1/subdir_with_ࢺ_/[0m
2025/06/14 03:05:01 NOTICE: [36m(03) :[0m [34mfix-names TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/extended_filenames/path2/subdir_with_ࢺ_/[0m
2025/06/14 03:05:01 NOTICE: [36m(04) :[0m [34mfix-names /tmp/025314qe/extended_filenames/path1/subdir_with_ࢺ_/filename_contains_ě_.txt[0m
2025/06/14 03:05:01 NOTICE: [36m(05) :[0m [34mfix-names TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/extended_filenames/path2/subdir_with_ࢺ_/filename_contains_ě_.txt[0m
2025/06/14 03:05:10 NOTICE: [36m(06) :[0m [34mfix-names /tmp/025314qe/extended_filenames/path1/Русский.txt[0m
2025/06/14 03:05:10 NOTICE: [36m(07) :[0m [34mfix-names TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/extended_filenames/path2/Русский.txt[0m
2025/06/14 03:05:14 NOTICE: [36m(08) :[0m [34mfix-names /tmp/025314qe/extended_filenames/path1/file_enconde_mañana_funcionará.txt[0m
2025/06/14 03:05:14 NOTICE: [36m(09) :[0m [34mfix-names TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/extended_filenames/path2/file_enconde_mañana_funcionará.txt[0m
2025/06/14 03:05:19 NOTICE: [36m(10) :[0m [34mtest initial bisync[0m
2025/06/14 03:05:19 NOTICE: [36m(11) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/filters
2025/06/14 03:05:26 ERROR : error listing: directory not found
2025/06/14 03:05:27 ERROR : error listing: directory not found
2025/06/14 03:05:27 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_filters-dolisid9
2025/06/14 03:05:27 NOTICE: checking Path1 Local file system at /tmp/025314qe/filters/path1
2025/06/14 03:06:01 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/filters/path2'
2025/06/14 03:06:03 NOTICE: [36m(01) :[0m [34mtest filters[0m
2025/06/14 03:06:03 NOTICE: [36m(02) :[0m [34mcopy-file /tmp/025314qe/datadir/test_filters-nahinex5/filtersfile.flt /tmp/025314qe/workdir/[0m
2025/06/14 03:06:03 NOTICE: [36m(03) :[0m [34mtest resync to force building of the filters md5 hash[0m
2025/06/14 03:06:03 NOTICE: [36m(04) :[0m [34mbisync filters-file=/tmp/025314qe/workdir/filtersfile.flt resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/filtersfile_checks
2025/06/14 03:06:10 ERROR : error listing: directory not found
2025/06/14 03:06:12 ERROR : error listing: directory not found
2025/06/14 03:06:12 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_filtersfile_checks-yekoxaw5
2025/06/14 03:06:12 NOTICE: checking Path1 Local file system at /tmp/025314qe/filtersfile_checks/path1
2025/06/14 03:06:33 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/filtersfile_checks/path2'
2025/06/14 03:06:34 NOTICE: [36m(01) :[0m [34mtest filtersfile-checks[0m
2025/06/14 03:06:34 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:06:34 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/ignorelistingchecksum
2025/06/14 03:06:39 ERROR : error listing: directory not found
2025/06/14 03:06:40 ERROR : error listing: directory not found
2025/06/14 03:06:41 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_ignorelistingchecksum-yunamer0
2025/06/14 03:06:41 NOTICE: checking Path1 Local file system at /tmp/025314qe/ignorelistingchecksum/path1
2025/06/14 03:07:12 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/ignorelistingchecksum/path2'
2025/06/14 03:07:13 NOTICE: [36m(01) :[0m [34mtest basic[0m
2025/06/14 03:07:13 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:07:13 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/max_delete_path1
2025/06/14 03:07:20 ERROR : error listing: directory not found
2025/06/14 03:07:22 ERROR : error listing: directory not found
2025/06/14 03:07:22 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_max_delete_path1-tubejid3
2025/06/14 03:07:22 NOTICE: checking Path1 Local file system at /tmp/025314qe/max_delete_path1/path1
2025/06/14 03:07:53 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/max_delete_path1/path2'
2025/06/14 03:07:54 NOTICE: [36m(01) :[0m [34mtest max-delete-path1[0m
2025/06/14 03:07:54 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:07:54 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/max_delete_path2_force
2025/06/14 03:08:03 ERROR : error listing: directory not found
2025/06/14 03:08:04 ERROR : error listing: directory not found
2025/06/14 03:08:04 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_max_delete_path2_force-xewetut4
2025/06/14 03:08:04 NOTICE: checking Path1 Local file system at /tmp/025314qe/max_delete_path2_force/path1
2025/06/14 03:08:34 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/max_delete_path2_force/path2'
2025/06/14 03:08:35 NOTICE: [36m(01) :[0m [34mtest max-delete-path2-force[0m
2025/06/14 03:08:35 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:08:35 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/nomodtime
2025/06/14 03:08:42 ERROR : error listing: directory not found
2025/06/14 03:08:43 ERROR : error listing: directory not found
2025/06/14 03:08:43 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_nomodtime-tucamez6
2025/06/14 03:08:43 NOTICE: checking Path1 Local file system at /tmp/025314qe/nomodtime/path1
2025/06/14 03:09:17 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/nomodtime/path2'
2025/06/14 03:09:17 NOTICE: [36m(01) :[0m [34mtest changes[0m
2025/06/14 03:09:17 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:09:17 NOTICE: [36m(03) :[0m [34mbisync resync nomodtime[0m
2025/06/14 03:09:21 NOTICE: Local file system at /tmp/025314qe/nomodtime/path1: [33mwill use md5 for same-side diffs on Path1 only[0m
2025/06/14 03:09:21 INFO : Bisyncing with Comparison Settings:
{
"Modtime": false,
"Size": true,
"Checksum": true,
"HashType1": 1,
"HashType2": 0,
"NoSlowHash": false,
"SlowHashSyncOnly": false,
"SlowHashDetected": true,
"DownloadHash": true
}
2025/06/14 03:09:21 INFO : Synching Path1 "/tmp/025314qe/nomodtime/path1/" with Path2 "TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/"
2025/06/14 03:09:21 INFO : Copying Path2 files to Path1
2025/06/14 03:09:21 INFO : - [34mPath2[0m [35mResync is copying files to[0m - [36mPath1[0m
2025/06/14 03:09:22 INFO : TestPremiumizeMe: [2mDownloading hashes...[0m
2025/06/14 03:09:23 INFO : - [36mPath1[0m [35mResync is copying files to[0m - [36mPath2[0m
2025/06/14 03:09:24 INFO : Resync updating listings
2025/06/14 03:09:24 INFO : Validating listings for Path1 "/tmp/025314qe/nomodtime/path1/" vs Path2 "TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/"
2025/06/14 03:09:24 INFO : [32mBisync successful[0m
2025/06/14 03:09:24 NOTICE: [36m(04) :[0m [34mtest make modifications on both paths[0m
2025/06/14 03:09:24 NOTICE: [36m(05) :[0m [34mtest new on path2 - file10[0m
2025/06/14 03:09:24 NOTICE: [36m(06) :[0m [34mcopy-file /tmp/025314qe/datadir/test_nomodtime-qimazos6/file10.txt TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/[0m
2025/06/14 03:09:32 NOTICE: [36m(07) :[0m [34mtest changed on path2 - file1[0m
2025/06/14 03:09:32 NOTICE: [36m(08) :[0m [34mcopy-file /tmp/025314qe/datadir/test_nomodtime-qimazos6/file1.txt TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/[0m
2025/06/14 03:09:40 NOTICE: [36m(09) :[0m [34mtest new on path1 - file11[0m
2025/06/14 03:09:40 NOTICE: [36m(10) :[0m [34mcopy-file /tmp/025314qe/datadir/test_nomodtime-qimazos6/file11.txt /tmp/025314qe/nomodtime/path1/[0m
2025/06/14 03:09:40 NOTICE: [36m(11) :[0m [34mtest changed on path1 - file2[0m
2025/06/14 03:09:40 NOTICE: [36m(12) :[0m [34mcopy-file /tmp/025314qe/datadir/test_nomodtime-qimazos6/file2.txt /tmp/025314qe/nomodtime/path1/[0m
2025/06/14 03:09:40 NOTICE: [36m(13) :[0m [34mtest deleted on path2 - file3[0m
2025/06/14 03:09:40 NOTICE: [36m(14) :[0m [34mdelete-file TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/file3.txt[0m
2025/06/14 03:09:46 NOTICE: [36m(15) :[0m [34mtest deleted on path1 - file4[0m
2025/06/14 03:09:46 NOTICE: [36m(16) :[0m [34mdelete-file /tmp/025314qe/nomodtime/path1/file4.txt[0m
2025/06/14 03:09:46 NOTICE: [36m(17) :[0m [34mtest deleted on both paths - file8[0m
2025/06/14 03:09:46 NOTICE: [36m(18) :[0m [34mdelete-file /tmp/025314qe/nomodtime/path1/file8.txt[0m
2025/06/14 03:09:46 NOTICE: [36m(19) :[0m [34mdelete-file TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/file8.txt[0m
2025/06/14 03:09:47 NOTICE: [36m(20) :[0m [34mtest changed on both paths - file5 (file5R, file5L)[0m
2025/06/14 03:09:47 NOTICE: [36m(21) :[0m [34mcopy-as /tmp/025314qe/datadir/test_nomodtime-qimazos6/file5R.txt TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/ file5.txt[0m
2025/06/14 03:09:58 NOTICE: [36m(22) :[0m [34mcopy-as /tmp/025314qe/datadir/test_nomodtime-qimazos6/file5L.txt /tmp/025314qe/nomodtime/path1/ file5.txt[0m
2025/06/14 03:09:58 NOTICE: [36m(23) :[0m [34mtest changed on path2 and deleted on path1 - file6[0m
2025/06/14 03:09:58 NOTICE: [36m(24) :[0m [34mcopy-file /tmp/025314qe/datadir/test_nomodtime-qimazos6/file6.txt TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/[0m
2025/06/14 03:10:07 NOTICE: [36m(25) :[0m [34mdelete-file /tmp/025314qe/nomodtime/path1/file6.txt[0m
2025/06/14 03:10:07 NOTICE: [36m(26) :[0m [34mtest changed on path1 and deleted on path2 - file7[0m
2025/06/14 03:10:07 NOTICE: [36m(27) :[0m [34mcopy-file /tmp/025314qe/datadir/test_nomodtime-qimazos6/file7.txt /tmp/025314qe/nomodtime/path1/[0m
2025/06/14 03:10:07 NOTICE: [36m(28) :[0m [34mdelete-file TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/file7.txt[0m
2025/06/14 03:10:07 NOTICE: [36m(29) :[0m [34mtest bisync run[0m
2025/06/14 03:10:07 NOTICE: [36m(30) :[0m [34mbisync nomodtime[0m
2025/06/14 03:10:13 NOTICE: Local file system at /tmp/025314qe/nomodtime/path1: [33mwill use md5 for same-side diffs on Path1 only[0m
2025/06/14 03:10:13 INFO : Bisyncing with Comparison Settings:
{
"Modtime": false,
"Size": true,
"Checksum": true,
"HashType1": 1,
"HashType2": 0,
"NoSlowHash": false,
"SlowHashSyncOnly": false,
"SlowHashDetected": true,
"DownloadHash": true
}
2025/06/14 03:10:13 INFO : Synching Path1 "/tmp/025314qe/nomodtime/path1/" with Path2 "TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/"
2025/06/14 03:10:13 INFO : Building Path1 and Path2 listings
2025/06/14 03:10:13 INFO : TestPremiumizeMe: [2mDownloading hashes...[0m
2025/06/14 03:10:15 INFO : Path1 checking for diffs
2025/06/14 03:10:15 INFO : - [36mPath1[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile2.txt[0m
2025/06/14 03:10:15 INFO : - [36mPath1[0m [35m[31mFile was deleted[0m[0m - [36mfile4.txt[0m
2025/06/14 03:10:15 INFO : - [36mPath1[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile5.txt[0m
2025/06/14 03:10:15 INFO : - [36mPath1[0m [35m[31mFile was deleted[0m[0m - [36mfile6.txt[0m
2025/06/14 03:10:15 INFO : - [36mPath1[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile7.txt[0m
2025/06/14 03:10:15 INFO : - [36mPath1[0m [35m[31mFile was deleted[0m[0m - [36mfile8.txt[0m
2025/06/14 03:10:15 INFO : - [36mPath1[0m [35m[32mFile is new[0m[0m - [36mfile11.txt[0m
2025/06/14 03:10:15 INFO : Path1: 7 changes: [32m 1 new[0m, [33m 3 modified[0m, [31m 3 deleted[0m
2025/06/14 03:10:15 INFO : ([33mModified[0m: [36m 3 larger[0m, [34m 0 smaller[0m, [36m 3 hash differs[0m)
2025/06/14 03:10:15 INFO : Path2 checking for diffs
2025/06/14 03:10:15 INFO : - [34mPath2[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile1.txt[0m
2025/06/14 03:10:15 INFO : - [34mPath2[0m [35m[31mFile was deleted[0m[0m - [36mfile3.txt[0m
2025/06/14 03:10:15 INFO : - [34mPath2[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile5.txt[0m
2025/06/14 03:10:15 INFO : - [34mPath2[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile6.txt[0m
2025/06/14 03:10:15 INFO : - [34mPath2[0m [35m[31mFile was deleted[0m[0m - [36mfile7.txt[0m
2025/06/14 03:10:15 INFO : - [34mPath2[0m [35m[31mFile was deleted[0m[0m - [36mfile8.txt[0m
2025/06/14 03:10:15 INFO : - [34mPath2[0m [35m[32mFile is new[0m[0m - [36mfile10.txt[0m
2025/06/14 03:10:15 INFO : Path2: 7 changes: [32m 1 new[0m, [33m 3 modified[0m, [31m 3 deleted[0m
2025/06/14 03:10:15 INFO : ([33mModified[0m: [36m 3 larger[0m, [34m 0 smaller[0m, [36m 3 hash differs[0m)
2025/06/14 03:10:15 INFO : Applying changes
2025/06/14 03:10:15 INFO : - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36mTestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/file11.txt[0m
2025/06/14 03:10:15 INFO : - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36mTestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/file2.txt[0m
2025/06/14 03:10:15 INFO : - [34mPath2[0m [35m[31mQueue delete[0m[0m - [36mTestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/file4.txt[0m
2025/06/14 03:10:15 NOTICE: - [34mWARNING[0m [35mNew or changed in both paths[0m - [36mfile5.txt[0m
2025/06/14 03:10:15 NOTICE: - [36mPath1[0m [35mRenaming Path1 copy[0m - [36m/tmp/025314qe/nomodtime/path1/file5.txt.conflict1[0m
2025/06/14 03:10:15 INFO : file5.txt: Moved (server-side) to: file5.txt.conflict1
2025/06/14 03:10:15 NOTICE: - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36mTestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/file5.txt.conflict1[0m
2025/06/14 03:10:15 NOTICE: - [34mPath2[0m [35mRenaming Path2 copy[0m - [36mTestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/file5.txt.conflict2[0m
2025/06/14 03:10:18 INFO : file5.txt: Moved (server-side) to: file5.txt.conflict2
2025/06/14 03:10:18 NOTICE: - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36m/tmp/025314qe/nomodtime/path1/file5.txt.conflict2[0m
2025/06/14 03:10:18 INFO : - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36m/tmp/025314qe/nomodtime/path1/file6.txt[0m
2025/06/14 03:10:18 INFO : - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36mTestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/file7.txt[0m
2025/06/14 03:10:18 INFO : - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36m/tmp/025314qe/nomodtime/path1/file1.txt[0m
2025/06/14 03:10:18 INFO : - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36m/tmp/025314qe/nomodtime/path1/file10.txt[0m
2025/06/14 03:10:18 INFO : - [36mPath1[0m [35m[31mQueue delete[0m[0m - [36m/tmp/025314qe/nomodtime/path1/file3.txt[0m
2025/06/14 03:10:18 INFO : - [34mPath2[0m [35mDo queued copies to[0m - [36mPath1[0m
2025/06/14 03:10:20 INFO : file10.txt: Copied (new)
2025/06/14 03:10:21 INFO : file1.txt: Copied (replaced existing)
2025/06/14 03:10:21 INFO : file5.txt.conflict2: Copied (new)
2025/06/14 03:10:21 INFO : file6.txt: Copied (new)
2025/06/14 03:10:21 INFO : file3.txt: Deleted
2025/06/14 03:10:21 INFO : - [36mPath1[0m [35mDo queued copies to[0m - [36mPath2[0m
2025/06/14 03:10:29 INFO : file11.txt: Copied (new)
2025/06/14 03:10:32 INFO : file2.txt: Copied (replaced existing)
2025/06/14 03:10:33 INFO : file7.txt: Copied (new)
2025/06/14 03:10:34 INFO : file5.txt.conflict1: Copied (new)
2025/06/14 03:10:34 INFO : file4.txt: Deleted
2025/06/14 03:10:34 INFO : Updating listings
2025/06/14 03:10:34 INFO : Validating listings for Path1 "/tmp/025314qe/nomodtime/path1/" vs Path2 "TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/nomodtime/path2/"
2025/06/14 03:10:34 INFO : [32mBisync successful[0m
bisync_test.go:560: [32mTEST nomodtime PASSED[0m
=== RUN TestBisyncLocalRemote/normalization
2025/06/14 03:10:42 ERROR : error listing: directory not found
2025/06/14 03:10:43 ERROR : error listing: directory not found
2025/06/14 03:10:43 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_normalization-ludezuq2
2025/06/14 03:10:43 NOTICE: checking Path1 Local file system at /tmp/025314qe/normalization/path1
2025/06/14 03:11:06 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/normalization/path2'
2025/06/14 03:11:07 NOTICE: [36m(01) :[0m [34mtest normalization[0m
2025/06/14 03:11:07 NOTICE: [36m(02) :[0m [34mtouch-copy 2001-01-02 /tmp/025314qe/datadir/test_normalization-fuputex0/file1.txt TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/normalization/path2/[0m
2025/06/14 03:11:17 NOTICE: [36m(03) :[0m [34mtest initial bisync[0m
2025/06/14 03:11:17 NOTICE: [36m(04) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/rclone_args
2025/06/14 03:11:23 ERROR : error listing: directory not found
2025/06/14 03:11:24 ERROR : error listing: directory not found
2025/06/14 03:11:24 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_rclone_args-zisipag7
2025/06/14 03:11:24 NOTICE: checking Path1 Local file system at /tmp/025314qe/rclone_args/path1
2025/06/14 03:11:46 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/rclone_args/path2'
2025/06/14 03:11:49 NOTICE: [36m(01) :[0m [34mtest rclone-args[0m
2025/06/14 03:11:49 NOTICE: [36m(02) :[0m [34mtouch-glob 2001-01-02 /tmp/025314qe/datadir/test_rclone_args-balizaf7/ *[0m
2025/06/14 03:11:49 NOTICE: [36m(03) :[0m [34mtest initial bisync[0m
2025/06/14 03:11:49 NOTICE: [36m(04) :[0m [34mbisync resync checksum[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/resolve
2025/06/14 03:11:55 ERROR : error listing: directory not found
2025/06/14 03:11:56 ERROR : error listing: directory not found
2025/06/14 03:11:56 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_resolve-kumacas3
2025/06/14 03:11:56 NOTICE: checking Path1 Local file system at /tmp/025314qe/resolve/path1
2025/06/14 03:12:10 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/resolve/path2'
2025/06/14 03:12:11 NOTICE: [36m(01) :[0m [34mtest resolve[0m
2025/06/14 03:12:11 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:12:11 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/resync
2025/06/14 03:12:20 ERROR : error listing: directory not found
2025/06/14 03:12:21 ERROR : error listing: directory not found
2025/06/14 03:12:21 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_resync-muqewuf8
2025/06/14 03:12:21 NOTICE: checking Path1 Local file system at /tmp/025314qe/resync/path1
2025/06/14 03:12:49 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/resync/path2'
2025/06/14 03:12:49 NOTICE: [36m(01) :[0m [34mtest resync[0m
2025/06/14 03:12:49 NOTICE: [36m(02) :[0m [34mtest 1. resync with empty path1, resulting in copying all content from path2.[0m
2025/06/14 03:12:49 NOTICE: [36m(03) :[0m [34mpurge-children /tmp/025314qe/resync/path1/[0m
2025/06/14 03:12:49 NOTICE: [36m(04) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/resync_modes
2025/06/14 03:12:56 ERROR : error listing: directory not found
2025/06/14 03:12:57 ERROR : error listing: directory not found
2025/06/14 03:12:57 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_resync_modes-ladoner2
2025/06/14 03:12:57 NOTICE: checking Path1 Local file system at /tmp/025314qe/resync_modes/path1
2025/06/14 03:13:13 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/resync_modes/path2'
2025/06/14 03:13:13 NOTICE: [36m(01) :[0m [34mtest resync-mode[0m
2025/06/14 03:13:13 NOTICE: [36m(02) :[0m [34mtest changed on both paths and NOT identical - file1 (file1R, file1L)[0m
2025/06/14 03:13:13 NOTICE: [36m(03) :[0m [34mtouch-glob 2001-01-02 /tmp/025314qe/datadir/test_resync_modes-zigeriz7/ file1R.txt[0m
2025/06/14 03:13:13 NOTICE: [36m(04) :[0m [34mcopy-as /tmp/025314qe/datadir/test_resync_modes-zigeriz7/file1R.txt TestPremiumizeMe:rclone-test-fezerof8gera/025314qe/resync_modes/path2/ file1.txt[0m
2025/06/14 03:13:21 NOTICE: [36m(05) :[0m [34mtouch-glob 2001-03-04 /tmp/025314qe/datadir/test_resync_modes-zigeriz7/ file1L.txt[0m
2025/06/14 03:13:21 NOTICE: [36m(06) :[0m [34mcopy-as /tmp/025314qe/datadir/test_resync_modes-zigeriz7/file1L.txt /tmp/025314qe/resync_modes/path1/ file1.txt[0m
2025/06/14 03:13:21 NOTICE: [36m(07) :[0m [34mtest bisync run with --resync-mode=newer[0m
2025/06/14 03:13:21 NOTICE: [36m(08) :[0m [34mbisync resync resync-mode=newer[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/rmdirs
2025/06/14 03:13:28 ERROR : error listing: directory not found
2025/06/14 03:13:30 ERROR : error listing: directory not found
2025/06/14 03:13:30 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_rmdirs-rupasaf2
2025/06/14 03:13:30 NOTICE: checking Path1 Local file system at /tmp/025314qe/rmdirs/path1
2025/06/14 03:14:00 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/rmdirs/path2'
2025/06/14 03:14:03 NOTICE: [36m(01) :[0m [34mtest rmdirs[0m
2025/06/14 03:14:03 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:14:03 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncLocalRemote/volatile
2025/06/14 03:14:09 ERROR : error listing: directory not found
2025/06/14 03:14:10 ERROR : error listing: directory not found
2025/06/14 03:14:10 NOTICE: checking initFs Local file system at /tmp/025314qe/initdir/test_volatile-nirebub3
2025/06/14 03:14:10 NOTICE: checking Path1 Local file system at /tmp/025314qe/volatile/path1
2025/06/14 03:14:42 NOTICE: checking path2 premiumize.me root 'rclone-test-fezerof8gera/025314qe/volatile/path2'
2025/06/14 03:14:43 NOTICE: [36m(01) :[0m [34mtest volatile[0m
2025/06/14 03:14:43 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:14:43 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:937: skipping 'volatile' test on non-local as it requires uploading 100 files
--- PASS: TestBisyncLocalRemote (1292.84s)
--- SKIP: TestBisyncLocalRemote/all_changed (48.96s)
--- SKIP: TestBisyncLocalRemote/backupdir (41.16s)
--- SKIP: TestBisyncLocalRemote/basic (40.91s)
--- SKIP: TestBisyncLocalRemote/changes (41.00s)
--- SKIP: TestBisyncLocalRemote/check_access (38.26s)
--- SKIP: TestBisyncLocalRemote/check_access_filters (92.02s)
--- SKIP: TestBisyncLocalRemote/check_filename (38.59s)
--- SKIP: TestBisyncLocalRemote/check_sync (40.04s)
--- SKIP: TestBisyncLocalRemote/compare_all (41.07s)
--- SKIP: TestBisyncLocalRemote/concurrent (41.29s)
--- SKIP: TestBisyncLocalRemote/createemptysrcdirs (34.52s)
--- SKIP: TestBisyncLocalRemote/dry_run (38.40s)
--- SKIP: TestBisyncLocalRemote/equal (22.84s)
--- SKIP: TestBisyncLocalRemote/ext_paths (101.54s)
--- SKIP: TestBisyncLocalRemote/extended_filenames (64.39s)
--- SKIP: TestBisyncLocalRemote/filters (44.17s)
--- SKIP: TestBisyncLocalRemote/filtersfile_checks (31.01s)
--- SKIP: TestBisyncLocalRemote/ignorelistingchecksum (38.99s)
--- SKIP: TestBisyncLocalRemote/max_delete_path1 (41.05s)
--- SKIP: TestBisyncLocalRemote/max_delete_path2_force (40.61s)
--- PASS: TestBisyncLocalRemote/nomodtime (120.64s)
--- SKIP: TestBisyncLocalRemote/normalization (40.90s)
--- SKIP: TestBisyncLocalRemote/rclone_args (32.04s)
--- SKIP: TestBisyncLocalRemote/resolve (22.83s)
--- SKIP: TestBisyncLocalRemote/resync (37.86s)
--- SKIP: TestBisyncLocalRemote/resync_modes (32.09s)
--- SKIP: TestBisyncLocalRemote/rmdirs (41.22s)
--- SKIP: TestBisyncLocalRemote/volatile (40.62s)
=== RUN TestBisyncRemoteRemote
2025/06/14 03:14:47 NOTICE: remote: TestPremiumizeMe:rclone-test-zaqoked0veji
=== RUN TestBisyncRemoteRemote/all_changed
2025/06/14 03:15:12 ERROR : error listing: directory not found
2025/06/14 03:15:14 ERROR : error listing: directory not found
2025/06/14 03:15:14 NOTICE: checking initFs Local file system at /tmp/031447de/initdir/test_all_changed-jabasux6
2025/06/14 03:15:44 NOTICE: checking Path1 premiumize.me root 'rclone-test-zaqoked0veji/031447de/all_changed/path1'
2025/06/14 03:16:18 NOTICE: checking path2 premiumize.me root 'rclone-test-zaqoked0veji/031447de/all_changed/path2'
2025/06/14 03:16:20 NOTICE: [36m(01) :[0m [34mtest all-changed[0m
2025/06/14 03:16:20 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:16:20 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteRemote/backupdir
2025/06/14 03:16:33 ERROR : error listing: directory not found
2025/06/14 03:16:34 ERROR : error listing: directory not found
2025/06/14 03:16:34 NOTICE: checking initFs Local file system at /tmp/031447de/initdir/test_backupdir-mowuyik5
2025/06/14 03:17:07 NOTICE: checking Path1 premiumize.me root 'rclone-test-zaqoked0veji/031447de/backupdir/path1'
2025/06/14 03:17:38 NOTICE: checking path2 premiumize.me root 'rclone-test-zaqoked0veji/031447de/backupdir/path2'
2025/06/14 03:17:39 NOTICE: [36m(01) :[0m [34mtest backupdir[0m
2025/06/14 03:17:39 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:17:39 NOTICE: [36m(03) :[0m [34mbisync resync backupdir1=/tmp/031447de/workdir/backupdirs/backupdir1 backupdir2=/tmp/031447de/workdir/backupdirs/backupdir2[0m
bisync_test.go:934: backupdir test currently only works on local (it uses the workdir)
=== RUN TestBisyncRemoteRemote/basic
2025/06/14 03:17:55 ERROR : error listing: directory not found
2025/06/14 03:17:55 ERROR : error listing: directory not found
2025/06/14 03:17:55 NOTICE: checking initFs Local file system at /tmp/031447de/initdir/test_basic-qexazev0
2025/06/14 03:18:27 NOTICE: checking Path1 premiumize.me root 'rclone-test-zaqoked0veji/031447de/basic/path1'
2025/06/14 03:18:59 NOTICE: checking path2 premiumize.me root 'rclone-test-zaqoked0veji/031447de/basic/path2'
2025/06/14 03:19:00 NOTICE: [36m(01) :[0m [34mtest basic[0m
2025/06/14 03:19:00 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 03:19:00 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:968: skipping test as at least one remote does not support setting modtime
=== RUN TestBisyncRemoteRemote/changes
2025/06/14 03:19:16 ERROR : error listing: directory not found
2025/06/14 03:19:16 ERROR : error listing: directory not found
2025/06/14 03:19:16 NOTICE: checking initFs Local file system at /tmp/031447de/initdir/test_changes-renovut1
2025/06/14 03:19:48 NOTICE: checking Path1 premiumize.me root 'rclone-test-zaqoked0veji/031447de/changes/path1'
panic: test timed out after 1h0m0s
running tests:
TestBisyncRemoteRemote (5m10s)
TestBisyncRemoteRemote/changes (55s)
goroutine 48790 [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, 5 minutes]:
testing.(*T).Run(0xc00039ba40, {0x271e306?, 0xc00006dad8?}, 0x2844528)
/usr/local/go/src/testing/testing.go:1859 +0x431
testing.runTests.func1(0xc00039ba40)
/usr/local/go/src/testing/testing.go:2279 +0x37
testing.tRunner(0xc00039ba40, 0xc00006dc18)
/usr/local/go/src/testing/testing.go:1792 +0xf4
testing.runTests(0xc000910750, {0x3f39dc0, 0x3, 0x3}, {0x831580?, 0x3f9cf58?, 0x3f79180?})
/usr/local/go/src/testing/testing.go:2277 +0x4b4
testing.(*M).Run(0xc00062bb80)
/usr/local/go/src/testing/testing.go:2142 +0x64a
github.com/rclone/rclone/fstest.TestMain(0xc00062bb80)
/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:69 +0xa5
github.com/rclone/rclone/cmd/bisync_test.TestMain(...)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:229
main.main()
_testmain.go:53 +0xa9
goroutine 12 [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 11 [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 11935 [select, 40 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e61d80)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 10880
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 13 [select, 60 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004b9480)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 1
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 17863 [select, 32 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000dc1480)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 16754
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 77 [select, 60 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0009b04c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 76
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 10549 [select, 41 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0002e6b40)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 10548
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 22143 [select, 27 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e61300)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 22142
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 19713 [select, 29 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e60080)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 19712
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 45192 [chan receive, 1 minutes]:
testing.(*T).Run(0xc000bba540, {0xc0008c8fc5?, 0x2b49738?}, 0xc0002f1860)
/usr/local/go/src/testing/testing.go:1859 +0x431
github.com/rclone/rclone/cmd/bisync_test.testBisync(0xc000bba540, {0xc001308c60, 0x29}, {0xc001308c60, 0x29})
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:351 +0x915
github.com/rclone/rclone/cmd/bisync_test.TestBisyncRemoteRemote(0xc000bba540)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:263 +0xf4
testing.tRunner(0xc000bba540, 0x2844528)
/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 63 [chan receive, 60 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 76
/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68
goroutine 98 [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 76
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7
goroutine 162 [select, 60 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0009624c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 64
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48049 [IO wait, 1 minutes]:
internal/poll.runtime_pollWait(0x7422bc25d290, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000f7a680?, 0xc0004e1500?, 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(0xc000f7a680, {0xc0004e1500, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000f7a680, {0xc0004e1500?, 0xc0004eb908?, 0x41e9b1?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000148b20, {0xc0004e1500?, 0xc000aa68d0?, 0x7422740c2ec8?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000d32be8, {0xc0004e1500?, 0x7422740d7980?, 0x7422bc63e5c0?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000d3afc0, {0xc0004e1500?, 0xc0004eb980?, 0x422eb6?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000aa69b8, {0x2b5d940, 0xc000d3afc0})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000aa6708, {0x74226ddb5fa0, 0xc000d32be8}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000aa6708, 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(0xc000aa6708, {0xc000792000, 0x1000, 0xc000982d20?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000aa0360, {0xc000792000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc00082bf20)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc00082bf20, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000aa0360)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48043
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 39952 [select, 10 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000dbc9c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 38914
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 46219 [select, 3 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000a15880)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 46193
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 65 [select, 60 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000556500)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 64
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 26133 [select, 23 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000f4ec80)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 26132
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48557 [select]:
net/http.(*persistConn).writeLoop(0xc000944fc0)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48550
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 40277 [select, 10 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000f4fc40)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 38914
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 20902 [select, 28 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0002e72c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 20901
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 19100 [select, 30 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e60880)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 19099
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 38150 [select, 12 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000a15bc0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 38149
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48652 [select]:
net/http.(*persistConn).writeLoop(0xc000aa0c60)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48661
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 48666 [select]:
net/http.(*persistConn).writeLoop(0xc0008c46c0)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48656
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 48783 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0xc000488700)
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:221 +0xed
created by github.com/rclone/rclone/fs/accounting.newAccountSizeName in goroutine 48764
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:119 +0x436
goroutine 48101 [IO wait]:
internal/poll.runtime_pollWait(0x74226d5410d8, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000f7ab00?, 0xc0007ea000?, 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(0xc000f7ab00, {0xc0007ea000, 0x1000, 0x1000})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000f7ab00, {0xc0007ea000?, 0xa57?, 0xc0009252a0?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0005425a8, {0xc0007ea000?, 0xc0007ea5a4?, 0x5?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000d3ba10, {0xc0007ea000?, 0x7422740d7980?, 0x7422bc63e5c0?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000d3b128, {0xc0007ea000?, 0xa57?, 0x6?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000c4db38, {0x2b5d940, 0xc000d3b128})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000c4d888, {0x74226ddb5fa0, 0xc000d3ba10}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000c4d888, 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(0xc000c4d888, {0xc0007fe000, 0x1000, 0xc00054cca0?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
bufio.(*Reader).Read(0xc0009896e0, {0xc0008c0120, 0x9, 0x3eef330?})
/usr/local/go/src/bufio/bufio.go:245 +0x197
io.ReadAtLeast({0x2b5a840, 0xc0009896e0}, {0xc0008c0120, 0x9, 0x9}, 0x9)
/usr/local/go/src/io/io.go:335 +0x91
io.ReadFull(...)
/usr/local/go/src/io/io.go:354
net/http.http2readFrameHeader({0xc0008c0120, 0x9, 0xc0003662d0?}, {0x2b5a840?, 0xc0009896e0?})
/usr/local/go/src/net/http/h2_bundle.go:1805 +0x65
net/http.(*http2Framer).ReadFrame(0xc0008c00e0)
/usr/local/go/src/net/http/h2_bundle.go:2072 +0x7d
net/http.(*http2clientConnReadLoop).run(0xc00054cfa8)
/usr/local/go/src/net/http/h2_bundle.go:9933 +0xda
net/http.(*http2ClientConn).readLoop(0xc000d03180)
/usr/local/go/src/net/http/h2_bundle.go:9812 +0x79
created by net/http.(*http2Transport).newClientConn in goroutine 48100
/usr/local/go/src/net/http/h2_bundle.go:8334 +0xde5
goroutine 38915 [select, 11 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000f4fc00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 38914
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 34135 [select, 16 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e81f40)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 33272
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 24572 [select, 25 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000f4f940)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 24571
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48651 [IO wait]:
internal/poll.runtime_pollWait(0x74226d541df8, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc0000d8c00?, 0xc000b6b500?, 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(0xc0000d8c00, {0xc000b6b500, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc0000d8c00, {0xc000b6b500?, 0xa73?, 0xc001508640?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000148f58, {0xc000b6b500?, 0xc0001f56d0?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000f24858, {0xc000b6b500?, 0x74226d52b918?, 0x7422bc63e108?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000f258c0, {0xc000b6b500?, 0xa73?, 0xc00054f9d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0001f57b8, {0x2b5d940, 0xc000f258c0})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc0001f5508, {0x74226ddb5fa0, 0xc000f24858}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc0001f5508, 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(0xc0001f5508, {0xc000c62000, 0x1000, 0xc000f75b30?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000aa0c60, {0xc000c62000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000989380)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000989380, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000aa0c60)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48661
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 48561 [select]:
net/http.(*persistConn).writeLoop(0xc000aa0b40)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48536
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 30580 [select, 19 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000962e40)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 30579
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 8900 [select, 44 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004b8f00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 8899
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 47216 [IO wait, 1 minutes]:
internal/poll.runtime_pollWait(0x74226d541768, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000cc1b80?, 0xc000b69000?, 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(0xc000cc1b80, {0xc000b69000, 0x1000, 0x1000})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000cc1b80, {0xc000b69000?, 0xc18?, 0xc0012faa80?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0005424b8, {0xc000b69000?, 0xc000b693e3?, 0x5?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000f9bd70, {0xc000b69000?, 0x7422740d7980?, 0x7422bc63e5c0?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000d3b158, {0xc000b69000?, 0xc18?, 0x1?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000aa6d38, {0x2b5d940, 0xc000d3b158})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000aa6a88, {0x74226ddb5fa0, 0xc000f9bd70}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000aa6a88, 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(0xc000aa6a88, {0xc000d0b000, 0x1000, 0xc000ce9ca0?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
bufio.(*Reader).Read(0xc000c15140, {0xc00017a820, 0x9, 0x3eef330?})
/usr/local/go/src/bufio/bufio.go:245 +0x197
io.ReadAtLeast({0x2b5a840, 0xc000c15140}, {0xc00017a820, 0x9, 0x9}, 0x9)
/usr/local/go/src/io/io.go:335 +0x91
io.ReadFull(...)
/usr/local/go/src/io/io.go:354
net/http.http2readFrameHeader({0xc00017a820, 0x9, 0xc000f74720?}, {0x2b5a840?, 0xc000c15140?})
/usr/local/go/src/net/http/h2_bundle.go:1805 +0x65
net/http.(*http2Framer).ReadFrame(0xc00017a7e0)
/usr/local/go/src/net/http/h2_bundle.go:2072 +0x7d
net/http.(*http2clientConnReadLoop).run(0xc000ce9fa8)
/usr/local/go/src/net/http/h2_bundle.go:9933 +0xda
net/http.(*http2ClientConn).readLoop(0xc000bba380)
/usr/local/go/src/net/http/h2_bundle.go:9812 +0x79
created by net/http.(*http2Transport).newClientConn in goroutine 47215
/usr/local/go/src/net/http/h2_bundle.go:8334 +0xde5
goroutine 48728 [IO wait]:
internal/poll.runtime_pollWait(0x7422bc25c8b8, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000d01380?, 0xc000cf9500?, 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(0xc000d01380, {0xc000cf9500, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000d01380, {0xc000cf9500?, 0xa73?, 0xc001509140?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0001491f0, {0xc000cf9500?, 0xc0005ecc50?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000db0870, {0xc000cf9500?, 0x7422740d7980?, 0x7422bc63e5c0?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000d3af90, {0xc000cf9500?, 0xa73?, 0xc0000999d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0005ecd38, {0x2b5d940, 0xc000d3af90})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc0005eca88, {0x74226ddb5fa0, 0xc000db0870}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc0005eca88, 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(0xc0005eca88, {0xc000dd8000, 0x1000, 0xc000f75b30?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc0004f26c0, {0xc000dd8000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000a00600)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000a00600, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc0004f26c0)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48705
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 9554 [select, 43 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000cba600)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 8899
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 13982 [select, 35 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e80180)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 13981
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 41416 [select, 9 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e5fa80)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 41415
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48560 [IO wait]:
internal/poll.runtime_pollWait(0x7422bc25cd18, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000d00a00?, 0xc0004df500?, 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(0xc000d00a00, {0xc0004df500, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000d00a00, {0xc0004df500?, 0xa73?, 0xc00043d700?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000148d60, {0xc0004df500?, 0xc0001f5350?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000d32c48, {0xc0004df500?, 0x74226de80978?, 0x7422bc63ea78?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000b46270, {0xc0004df500?, 0xa73?, 0xc00009a9d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0001f5438, {0x2b5d940, 0xc000b46270})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc0001f5188, {0x74226ddb5fa0, 0xc000d32c48}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc0001f5188, 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(0xc0001f5188, {0xc00076a000, 0x1000, 0xc000f75b30?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000aa0b40, {0xc00076a000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc00082b020)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc00082b020, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000aa0b40)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48536
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 9483 [select, 43 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00051bb00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 8899
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 12222 [select, 38 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000dbd880)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 12221
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 28977 [select, 21 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0002e7f40)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 28976
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 21281 [select, 28 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004b9d00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 21280
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 8030 [select, 45 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000557000)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 8029
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 23742 [select, 26 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e60840)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 23741
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 43616 [select, 6 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000cbafc0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 43615
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48627 [select]:
net/http.(*persistConn).writeLoop(0xc000833560)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48614
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 48804 [chan receive]:
github.com/rclone/rclone/backend/local.(*fadvise).worker(0xc000f4f140)
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:114 +0x3f
created by github.com/rclone/rclone/backend/local.newFadvise in goroutine 48766
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:74 +0x11f
goroutine 23061 [select, 26 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000dc1000)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 22974
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 17777 [select, 32 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000dc0880)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 16754
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 11867 [select, 40 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0009b1940)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 10880
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48062 [select, 1 minutes]:
net/http.(*persistConn).writeLoop(0xc0007b3680)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48055
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 836 [select, 57 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000cbb080)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 925
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 43110 [select, 7 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000962c40)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 43109
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48766 [sync.Mutex.Lock]:
internal/sync.runtime_SemacquireMutex(0xc0011637d8?, 0x25?, 0xc00007cf08?)
/usr/local/go/src/runtime/sema.go:95 +0x25
internal/sync.(*Mutex).lockSlow(0xc000c0a0b8)
/usr/local/go/src/internal/sync/mutex.go:149 +0x15d
internal/sync.(*Mutex).Lock(...)
/usr/local/go/src/internal/sync/mutex.go:70
sync.(*Mutex).Lock(...)
/usr/local/go/src/sync/mutex.go:46
github.com/rclone/rclone/lib/dircache.(*DirCache).FindDir(0xc000c0a090, {0x2b83288, 0xc001460960}, {0x0, 0x0}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:199 +0x7d
github.com/rclone/rclone/lib/dircache.(*DirCache).FindPath(0xc000c0a090, {0x2b83288, 0xc001460960}, {0xc0008c8130?, 0xc0011638c8?}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:275 +0xa9
github.com/rclone/rclone/backend/premiumizeme.(*Fs).readMetaDataForPath(0xc000e7f860, {0x2b83288, 0xc001460960}, {0xc0008c8130?, 0xffffffffffffffff?}, 0x0, 0x1)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:185 +0x5c
github.com/rclone/rclone/backend/premiumizeme.(*Object).readMetaData(0xc000cc0c00, {0x2b83288?, 0xc001460960?})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:868 +0x3f
github.com/rclone/rclone/backend/premiumizeme.(*Fs).newObjectWithInfo(0xc000e7f860, {0x2b83288, 0xc001460960}, {0xc0008c8130, 0x9}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:329 +0x9c
github.com/rclone/rclone/backend/premiumizeme.(*Fs).Put(0xc000e7f860, {0x2b83288, 0xc001460960}, {0x2b5b040, 0xc000354400}, {0x74226dd7d2e0, 0xc000a00de0}, {0xc000653e60, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:517 +0x79
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0xc000c0b7a0, {0x2b83288, 0xc001460960}, {0x2b6e680?, 0xc00039e1c0?}, {0xc000653e60, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:218 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc000c0b7a0, {0x2b83288, 0xc001460960})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:271 +0x6d8
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc000c0b7a0, {0x2b83288, 0xc001460960})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:311 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2b83288, 0xc001460960}, {0x2b9aea0, 0xc000e7f860}, {0x0, 0x0}, {0xc0008c8130, 0x9}, {0x2b9a500, 0xc000a00de0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:413 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc000cb2788, {0x2b83288, 0xc001460960}, 0xc0014608c0, {0x2b9aea0, 0xc000e7f860}, 0x4b, 0xc000a80000?)
/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 48088
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 3373 [select, 54 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00036cd40)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 3372
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48763 [chan receive]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc000e7f800)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x25
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc000e7f800, 0xc000cba0c0, 0xa)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x5c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc000e7f800, 0xc000cba0c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93
github.com/rclone/rclone/backend/premiumizeme.(*Fs).CreateDir(0xc000e7f860, {0x2b83288, 0xc001460960}, {0xc001362f60, 0x16}, {0xc000890d7b, 0x5})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:375 +0x4ad
github.com/rclone/rclone/lib/dircache.(*DirCache)._findDir(0xc000c0a090, {0x2b83288, 0xc001460960}, {0xc000890d51, 0x2f}, 0x1)
/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:242 +0x172
github.com/rclone/rclone/lib/dircache.(*DirCache)._findRoot(0xc000c0a090, {0x2b83288?, 0xc001460960?}, 0x0?)
/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:305 +0x45
github.com/rclone/rclone/lib/dircache.(*DirCache).FindDir(0xc000c0a090, {0x2b83288, 0xc001460960}, {0x0, 0x0}, 0x1)
/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:201 +0xcd
github.com/rclone/rclone/lib/dircache.(*DirCache).FindPath(0xc000c0a090, {0x2b83288, 0xc001460960}, {0xc0008c8160?, 0x0?}, 0x1)
/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:275 +0xa9
github.com/rclone/rclone/backend/premiumizeme.(*Fs).createObject(0xc000e7f860, {0x2b83288?, 0xc001460960?}, {0xc0008c8160, 0x9}, {0xc0008c8160?, 0xffffffffffffffff?, 0x100?}, 0xc00006d990?)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:499 +0x3d
github.com/rclone/rclone/backend/premiumizeme.(*Fs).PutUnchecked(0xc000e7f860, {0x2b83288, 0xc001460960}, {0x2b5b040, 0xc000354300}, {0x74226dd7d2e0, 0xc000a00ea0}, {0xc000653de0, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:541 +0xd7
github.com/rclone/rclone/backend/premiumizeme.(*Fs).Put(0xc000e7f860, {0x2b83288, 0xc001460960}, {0x2b5b040, 0xc000354300}, {0x74226dd7d2e0, 0xc000a00ea0}, {0xc000653de0, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:523 +0x12c
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0xc000c0b710, {0x2b83288, 0xc001460960}, {0x2b6e680?, 0xc00039e0e0?}, {0xc000653de0, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:218 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc000c0b710, {0x2b83288, 0xc001460960})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:271 +0x6d8
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc000c0b710, {0x2b83288, 0xc001460960})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:311 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2b83288, 0xc001460960}, {0x2b9aea0, 0xc000e7f860}, {0x0, 0x0}, {0xc0008c8160, 0x9}, {0x2b9a500, 0xc000a00ea0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:413 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc000cb2788, {0x2b83288, 0xc001460960}, 0xc0014608c0, {0x2b9aea0, 0xc000e7f860}, 0x0, 0xc0001f1700?)
/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 48088
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 17992 [select, 31 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e80f40)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 16754
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 45331 [select, 5 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000f4fd00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 45218
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 22978 [select, 26 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000f4e4c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 22849
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48784 [chan receive]:
github.com/rclone/rclone/backend/local.(*fadvise).worker(0xc0011ac340)
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:114 +0x3f
created by github.com/rclone/rclone/backend/local.newFadvise in goroutine 48765
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:74 +0x11f
goroutine 9741 [select, 43 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0005575c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 8899
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 41294 [select, 9 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000a14340)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 40776
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 20131 [select, 29 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000cbbf00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 20130
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 40160 [select, 10 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000f4e880)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 38914
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 42382 [select, 7 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0011ade80)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 42381
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 22973 [chan receive, 26 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 22849
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7
goroutine 32810 [select, 18 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e819c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 32809
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 18218 [chan receive (nil chan), 31 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 16754
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378
goroutine 5544 [select, 50 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e60b80)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 5543
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48765 [sync.Mutex.Lock]:
internal/sync.runtime_SemacquireMutex(0xc0004e47d8?, 0x25?, 0xc000078508?)
/usr/local/go/src/runtime/sema.go:95 +0x25
internal/sync.(*Mutex).lockSlow(0xc000c0a0b8)
/usr/local/go/src/internal/sync/mutex.go:149 +0x15d
internal/sync.(*Mutex).Lock(...)
/usr/local/go/src/internal/sync/mutex.go:70
sync.(*Mutex).Lock(...)
/usr/local/go/src/sync/mutex.go:46
github.com/rclone/rclone/lib/dircache.(*DirCache).FindDir(0xc000c0a090, {0x2b83288, 0xc001460960}, {0x0, 0x0}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:199 +0x7d
github.com/rclone/rclone/lib/dircache.(*DirCache).FindPath(0xc000c0a090, {0x2b83288, 0xc001460960}, {0xc0008c8190?, 0xc0004e48c8?}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:275 +0xa9
github.com/rclone/rclone/backend/premiumizeme.(*Fs).readMetaDataForPath(0xc000e7f860, {0x2b83288, 0xc001460960}, {0xc0008c8190?, 0xffffffffffffffff?}, 0x0, 0x1)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:185 +0x5c
github.com/rclone/rclone/backend/premiumizeme.(*Object).readMetaData(0xc000d01c00, {0x2b83288?, 0xc001460960?})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:868 +0x3f
github.com/rclone/rclone/backend/premiumizeme.(*Fs).newObjectWithInfo(0xc000e7f860, {0x2b83288, 0xc001460960}, {0xc0008c8190, 0x9}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:329 +0x9c
github.com/rclone/rclone/backend/premiumizeme.(*Fs).Put(0xc000e7f860, {0x2b83288, 0xc001460960}, {0x2b5b040, 0xc000488800}, {0x74226dd7d2e0, 0xc000a00f00}, {0xc00035aaf0, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:517 +0x79
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0xc000d0f9e0, {0x2b83288, 0xc001460960}, {0x2b6e680?, 0xc00017a700?}, {0xc00035aaf0, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:218 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc000d0f9e0, {0x2b83288, 0xc001460960})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:271 +0x6d8
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc000d0f9e0, {0x2b83288, 0xc001460960})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:311 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2b83288, 0xc001460960}, {0x2b9aea0, 0xc000e7f860}, {0x0, 0x0}, {0xc0008c8190, 0x9}, {0x2b9a500, 0xc000a00f00})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:413 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc000cb2788, {0x2b83288, 0xc001460960}, 0xc0014608c0, {0x2b9aea0, 0xc000e7f860}, 0x32, 0xc000aa0c60?)
/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 48088
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 4012 [select, 53 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0009b0140)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 4011
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 9681 [select, 43 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000962640)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 8899
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 13173 [select, 36 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00036cd00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 13172
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48782 [chan receive]:
github.com/rclone/rclone/backend/local.(*fadvise).worker(0xc0011ac300)
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:114 +0x3f
created by github.com/rclone/rclone/backend/local.newFadvise in goroutine 48764
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:74 +0x11f
goroutine 2568 [select, 55 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000556580)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 2567
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 15207 [select, 34 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004b8f40)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 15206
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48764 [sync.Mutex.Lock]:
internal/sync.runtime_SemacquireMutex(0xc000cf47d8?, 0x25?, 0xc000078508?)
/usr/local/go/src/runtime/sema.go:95 +0x25
internal/sync.(*Mutex).lockSlow(0xc000c0a0b8)
/usr/local/go/src/internal/sync/mutex.go:149 +0x15d
internal/sync.(*Mutex).Lock(...)
/usr/local/go/src/internal/sync/mutex.go:70
sync.(*Mutex).Lock(...)
/usr/local/go/src/sync/mutex.go:46
github.com/rclone/rclone/lib/dircache.(*DirCache).FindDir(0xc000c0a090, {0x2b83288, 0xc001460960}, {0x0, 0x0}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:199 +0x7d
github.com/rclone/rclone/lib/dircache.(*DirCache).FindPath(0xc000c0a090, {0x2b83288, 0xc001460960}, {0xc0008c8260?, 0xc000cf48c8?}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:275 +0xa9
github.com/rclone/rclone/backend/premiumizeme.(*Fs).readMetaDataForPath(0xc000e7f860, {0x2b83288, 0xc001460960}, {0xc0008c8260?, 0xffffffffffffffff?}, 0x0, 0x1)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:185 +0x5c
github.com/rclone/rclone/backend/premiumizeme.(*Object).readMetaData(0xc000d01b80, {0x2b83288?, 0xc001460960?})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:868 +0x3f
github.com/rclone/rclone/backend/premiumizeme.(*Fs).newObjectWithInfo(0xc000e7f860, {0x2b83288, 0xc001460960}, {0xc0008c8260, 0x9}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:329 +0x9c
github.com/rclone/rclone/backend/premiumizeme.(*Fs).Put(0xc000e7f860, {0x2b83288, 0xc001460960}, {0x2b5b040, 0xc000488700}, {0x74226dd7d2e0, 0xc000a010e0}, {0xc00035a610, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:517 +0x79
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0xc000d0f950, {0x2b83288, 0xc001460960}, {0x2b6e680?, 0xc00017a620?}, {0xc00035a610, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:218 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc000d0f950, {0x2b83288, 0xc001460960})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:271 +0x6d8
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc000d0f950, {0x2b83288, 0xc001460960})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:311 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2b83288, 0xc001460960}, {0x2b9aea0, 0xc000e7f860}, {0x0, 0x0}, {0xc0008c8260, 0x9}, {0x2b9a500, 0xc000a010e0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:413 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc000cb2788, {0x2b83288, 0xc001460960}, 0xc0014608c0, {0x2b9aea0, 0xc000e7f860}, 0x19, 0xc0008c46c0?)
/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 48088
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 9607 [select, 43 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000dc0240)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 8899
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48626 [IO wait]:
internal/poll.runtime_pollWait(0x74226d541420, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc0000d8880?, 0xc0007aaa80?, 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(0xc0000d8880, {0xc0007aaa80, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc0000d8880, {0xc0007aaa80?, 0xa73?, 0xc00043dc00?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc00008c5a8, {0xc0007aaa80?, 0xc00070ec50?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000d3a6f0, {0xc0007aaa80?, 0x74226d52b918?, 0x7422bc63e108?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000f24318, {0xc0007aaa80?, 0xa73?, 0xc0011629d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc00070ed38, {0x2b5d940, 0xc000f24318})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc00070ea88, {0x74226ddb5fa0, 0xc000d3a6f0}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc00070ea88, 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(0xc00070ea88, {0xc00078f000, 0x1000, 0xc000f75b30?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000833560, {0xc00078f000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000e62ea0)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000e62ea0, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000833560)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48614
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 7227 [select, 46 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004b8040)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 7226
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 1760 [select, 56 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000556040)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 1759
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48665 [IO wait]:
internal/poll.runtime_pollWait(0x74226d5411f0, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc0000d8c80?, 0xc000c68000?, 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(0xc0000d8c80, {0xc000c68000, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc0000d8c80, {0xc000c68000?, 0xa73?, 0xc001508940?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000149018, {0xc000c68000?, 0xc0005ec8d0?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000f258f0, {0xc000c68000?, 0x7422740da360?, 0x7422bc63e108?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000db0168, {0xc000c68000?, 0xa73?, 0xc0000989d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0005ec9b8, {0x2b5d940, 0xc000db0168})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc0005ec708, {0x74226ddb5fa0, 0xc000f258f0}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc0005ec708, 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(0xc0005ec708, {0xc000ab3000, 0x1000, 0xc000f75b30?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc0008c46c0, {0xc000ab3000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000ca2000)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000ca2000, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc0008c46c0)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48656
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 9645 [select, 43 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e61900)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 8899
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 33273 [select, 17 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000cbb880)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 33272
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 15953 [select, 33 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00051ae80)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 15952
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48556 [IO wait]:
internal/poll.runtime_pollWait(0x7422bc25cae8, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000cc0880?, 0xc0004dea80?, 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(0xc000cc0880, {0xc0004dea80, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000cc0880, {0xc0004dea80?, 0x2000?, 0x0?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000148c90, {0xc0004dea80?, 0x0?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000d32690, {0xc0004dea80?, 0x74226de80978?, 0x7422bc63ea78?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000b46090, {0xc0004dea80?, 0x3f9f3c0?, 0x980054a900?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000aa7438, {0x2b5d940, 0xc000b46090})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000aa7188, {0x74226ddb5fa0, 0xc000d32690}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000aa7188, 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(0xc000aa7188, {0xc0004c7000, 0x1000, 0xc000f75b30?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000944fc0, {0xc0004c7000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000ddb620)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000ddb620, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000944fc0)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48550
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 21330 [select, 28 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000f4f640)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 20901
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48803 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0xc000354300)
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:221 +0xed
created by github.com/rclone/rclone/fs/accounting.newAccountSizeName in goroutine 48763
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:119 +0x436
goroutine 34211 [select, 16 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004b8400)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 33272
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 41972 [select, 8 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0011ac000)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 41971
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48529 [IO wait]:
internal/poll.runtime_pollWait(0x74226d541ce0, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000d00900?, 0xc0004de000?, 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(0xc000d00900, {0xc0004de000, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000d00900, {0xc0004de000?, 0xa73?, 0xc00043d140?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000148b58, {0xc0004de000?, 0xc000aa6fd0?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000d321c8, {0xc0004de000?, 0x7422bc215988?, 0x7422bc63ef30?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc00102e960, {0xc0004de000?, 0xa73?, 0xc0011649d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000aa70b8, {0x2b5d940, 0xc00102e960})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000aa6e08, {0x74226ddb5fa0, 0xc000d321c8}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000aa6e08, 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(0xc000aa6e08, {0xc0008ab000, 0x1000, 0xc000f75b30?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc0008ac5a0, {0xc0008ab000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000cd8f60)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000cd8f60, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc0008ac5a0)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48508
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 44374 [select, 6 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000dbdc00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 44373
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48089 [select, 1 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000a15e00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 48088
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 14483 [select, 35 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00051b040)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 14482
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 47206 [select, 2 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e80040)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 47153
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48785 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0xc000488800)
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:221 +0xed
created by github.com/rclone/rclone/fs/accounting.newAccountSizeName in goroutine 48765
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:119 +0x436
goroutine 16755 [select, 33 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000dbc040)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 16754
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36119 [select, 14 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000a15d80)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 36118
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 10881 [select, 41 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e60240)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 10880
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 37351 [select, 12 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000a15640)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 37350
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48066 [select, 1 minutes]:
net/http.(*persistConn).writeLoop(0xc000aa0360)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48043
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 48683 [IO wait]:
internal/poll.runtime_pollWait(0x74226d541ab0, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000d01200?, 0xc000c69500?, 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(0xc000d01200, {0xc000c69500, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000d01200, {0xc000c69500?, 0xa73?, 0xc001508b80?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0009ac398, {0xc000c69500?, 0xc000ba61d0?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000b478a8, {0xc000c69500?, 0x74226de80978?, 0x7422bc63ea78?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000b47908, {0xc000c69500?, 0xa73?, 0x41b3d3?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000ba62b8, {0x2b5d940, 0xc000b47908})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000ba6008, {0x74226ddb5fa0, 0xc000b478a8}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000ba6008, 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(0xc000ba6008, {0xc000c97000, 0x1000, 0xc000f75b30?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000aa0d80, {0xc000c97000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000e7ff20)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000e7ff20, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000aa0d80)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48673
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 11868 [select, 40 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0009b1a00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 10880
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 6295 [select, 49 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00051b0c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 6294
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 9726 [select, 43 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000963d80)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 9725
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 32100 [select, 18 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004b89c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 32099
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 12034 [select, 38 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e807c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 10880
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48684 [select]:
net/http.(*persistConn).writeLoop(0xc000aa0d80)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48673
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 40025 [select, 10 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0009b0b00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 38914
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 28302 [select, 22 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0009b0ec0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 28301
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48729 [select]:
net/http.(*persistConn).writeLoop(0xc0004f26c0)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48705
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 48088 [sync.WaitGroup.Wait]:
sync.runtime_SemacquireWaitGroup(0x0?)
/usr/local/go/src/runtime/sema.go:110 +0x25
sync.(*WaitGroup).Wait(0xc001460807?)
/usr/local/go/src/sync/waitgroup.go:118 +0x48
github.com/rclone/rclone/fs/sync.(*syncCopyMove).stopTransfers(0xc000cb2788)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:543 +0x6f
github.com/rclone/rclone/fs/sync.(*syncCopyMove).run(0xc000cb2788)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:978 +0x325
github.com/rclone/rclone/fs/sync.runSyncCopyMove({0x2b83250, 0xc000e3bec0}, {0x2b9aea0, 0xc000e7f860}, {0x2b9a490, 0xc0007c3a40}, 0x0, 0x0, 0x0, 0x1, ...)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1366 +0x225
github.com/rclone/rclone/fs/sync.CopyDir(...)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1377
github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).runTestCase(0xc000bba8c0, {0x2b831a8, 0x3f9c9c0}, 0x66b?, {0xc0008c8fc5?, 0x55fc80?})
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:461 +0x101a
github.com/rclone/rclone/cmd/bisync_test.testBisync.func4(0xc000bba700)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358 +0x234
testing.tRunner(0xc000bba700, 0xc0002f1860)
/usr/local/go/src/testing/testing.go:1792 +0xf4
created by testing.(*T).Run in goroutine 45192
/usr/local/go/src/testing/testing.go:1851 +0x413
goroutine 45219 [select, 5 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0013d3cc0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 45218
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 18084 [select, 31 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000cba140)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 16754
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 34419 [select, 15 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e604c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 34418
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48543 [IO wait]:
internal/poll.runtime_pollWait(0x7422bc25d3a8, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000cc0900?, 0xc000c09500?, 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(0xc000cc0900, {0xc000c09500, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000cc0900, {0xc000c09500?, 0xa73?, 0xc00108ec20?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc00008c430, {0xc000c09500?, 0xc00070e550?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000383b00, {0xc000c09500?, 0x74226de80978?, 0x7422bc63ea78?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000b46840, {0xc000c09500?, 0xa73?, 0xc000cf79d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc00070e638, {0x2b5d940, 0xc000b46840})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc00070e388, {0x74226ddb5fa0, 0xc000383b00}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc00070e388, 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(0xc00070e388, {0xc0008c6000, 0x1000, 0xc000f75b30?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc0009450e0, {0xc0008c6000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc00066af60)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc00066af60, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc0009450e0)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48574
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 48544 [select]:
net/http.(*persistConn).writeLoop(0xc0009450e0)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48574
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 22975 [select, 26 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000dc0180)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 22974
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 31387 [select, 19 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0002e7980)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 31386
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 43511 [select, 6 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0011ad080)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 43109
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 29788 [select, 20 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000963a00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 29787
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 45193 [select, 5 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000962bc0)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 45192
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 45246 [select, 5 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000963a80)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 45218
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 25330 [select, 24 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000169300)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 25313
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48805 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0xc000354400)
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:221 +0xed
created by github.com/rclone/rclone/fs/accounting.newAccountSizeName in goroutine 48766
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:119 +0x436
goroutine 48137 [select, 1 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0013d2640)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 48088
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 40409 [chan receive (nil chan), 10 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 38914
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378
goroutine 48775 [chan receive]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 48088
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378
goroutine 47186 [select, 2 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000557b80)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 47153
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 18553 [select, 30 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000556440)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 18552
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 45153 [chan receive, 5 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 45192
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7
goroutine 48807 [sleep]:
time.Sleep(0x324a9a70)
/usr/local/go/src/runtime/time.go:338 +0x165
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall.func1(0xc001317760?)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:167 +0x1c
created by github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall in goroutine 48763
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:166 +0xef
goroutine 35302 [select, 14 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000a14240)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 35301
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36625 [select, 13 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e81680)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 36624
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 40777 [select, 9 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e5f280)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 40776
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 34257 [select, 16 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0009b0f00)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 33272
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 26794 [select, 23 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000f4e600)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 26793
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 46194 [select, 3 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0011ad740)
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x86
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 46193
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 48546 [select]:
net/http.(*persistConn).writeLoop(0xc0008ac5a0)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 48508
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 48061 [IO wait, 1 minutes]:
internal/poll.runtime_pollWait(0x74226d541538, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000d00480?, 0xc000a9f500?, 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(0xc000d00480, {0xc000a9f500, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000d00480, {0xc000a9f500?, 0x2000?, 0x0?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000542288, {0xc000a9f500?, 0x5?, 0x3f980e8?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000d3ac60, {0xc000a9f500?, 0x7422740d0958?, 0x7422bc63ea78?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc0011c2438, {0xc000a9f500?, 0x3f9f3c0?, 0xc00054d9d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000c4d7b8, {0x2b5d940, 0xc0011c2438})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000c4d508, {0x74226ddb5fa0, 0xc000d3ac60}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000c4d508, 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(0xc000c4d508, {0xc00069e000, 0x1000, 0xc000982d20?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc0007b3680, {0xc00069e000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc00066bb00)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc00066bb00, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc0007b3680)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 48055
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 48802 [chan receive]:
github.com/rclone/rclone/backend/local.(*fadvise).worker(0xc000f4f0c0)
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:114 +0x3f
created by github.com/rclone/rclone/backend/local.newFadvise in goroutine 48763
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:74 +0x11f
goroutine 48122 [IO wait]:
internal/poll.runtime_pollWait(0x7422bc25d4c0, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000f7ad00?, 0xc0006da000?, 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(0xc000f7ad00, {0xc0006da000, 0x1000, 0x1000})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000f7ad00, {0xc0006da000?, 0xebe?, 0xc0015095c0?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0005425f8, {0xc0006da000?, 0xc0006da13d?, 0x5?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000d3bbd8, {0xc0006da000?, 0x7422740da360?, 0x7422bc63ef30?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000db00d8, {0xc0006da000?, 0xebe?, 0x3?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000c4deb8, {0x2b5d940, 0xc000db00d8})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000c4dc08, {0x74226ddb5fa0, 0xc000d3bbd8}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000c4dc08, 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(0xc000c4dc08, {0xc0006ee000, 0x1000, 0xc001167ca0?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
bufio.(*Reader).Read(0xc000ca3d40, {0xc00017ac80, 0x9, 0x3eef330?})
/usr/local/go/src/bufio/bufio.go:245 +0x197
io.ReadAtLeast({0x2b5a840, 0xc000ca3d40}, {0xc00017ac80, 0x9, 0x9}, 0x9)
/usr/local/go/src/io/io.go:335 +0x91
io.ReadFull(...)
/usr/local/go/src/io/io.go:354
net/http.http2readFrameHeader({0xc00017ac80, 0x9, 0xc0004a7f20?}, {0x2b5a840?, 0xc000ca3d40?})
/usr/local/go/src/net/http/h2_bundle.go:1805 +0x65
net/http.(*http2Framer).ReadFrame(0xc00017ac40)
/usr/local/go/src/net/http/h2_bundle.go:2072 +0x7d
net/http.(*http2clientConnReadLoop).run(0xc001167fa8)
/usr/local/go/src/net/http/h2_bundle.go:9933 +0xda
net/http.(*http2ClientConn).readLoop(0xc000bbaa80)
/usr/local/go/src/net/http/h2_bundle.go:9812 +0x79
created by net/http.(*http2Transport).newClientConn in goroutine 48121
/usr/local/go/src/net/http/h2_bundle.go:8334 +0xde5
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestPremiumizeMe: -verbose" - Finished ERROR in 1h0m2.053226261s (try 2/5): exit status 2: Failed [TestBisyncRemoteLocal/check_sync]