"./bisync.test -test.v -test.timeout 1h0m0s -remote TestPremiumizeMe: -verbose" - Starting (try 1/5)
=== RUN TestBisyncRemoteLocal
2025/06/14 01:19:57 NOTICE: remote: TestPremiumizeMe:rclone-test-rozujam3towu
=== RUN TestBisyncRemoteLocal/all_changed
2025/06/14 01:20:17 ERROR : error listing: directory not found
2025/06/14 01:20:17 ERROR : error listing: directory not found
2025/06/14 01:20:17 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_all_changed-qequwed2
2025/06/14 01:21:26 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/all_changed/path1'
2025/06/14 01:21:29 NOTICE: checking path2 Local file system at /tmp/011957mu/all_changed/path2
2025/06/14 01:21:29 NOTICE: [36m(01) :[0m [34mtest all-changed[0m
2025/06/14 01:21:29 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:21:29 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 01:21:36 ERROR : error listing: directory not found
2025/06/14 01:21:36 ERROR : error listing: directory not found
2025/06/14 01:21:36 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_backupdir-hidijup6
2025/06/14 01:22:32 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/backupdir/path1'
2025/06/14 01:22:34 NOTICE: checking path2 Local file system at /tmp/011957mu/backupdir/path2
2025/06/14 01:22:34 NOTICE: [36m(01) :[0m [34mtest backupdir[0m
2025/06/14 01:22:34 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:22:34 NOTICE: [36m(03) :[0m [34mbisync resync backupdir1=/tmp/011957mu/workdir/backupdirs/backupdir1 backupdir2=/tmp/011957mu/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 01:22:41 ERROR : error listing: directory not found
2025/06/14 01:22:41 ERROR : error listing: directory not found
2025/06/14 01:22:41 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_basic-luluyeg6
2025/06/14 01:23:37 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/basic/path1'
2025/06/14 01:23:38 NOTICE: checking path2 Local file system at /tmp/011957mu/basic/path2
2025/06/14 01:23:38 NOTICE: [36m(01) :[0m [34mtest basic[0m
2025/06/14 01:23:38 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:23:38 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 01:23:49 ERROR : error listing: directory not found
2025/06/14 01:23:49 ERROR : error listing: directory not found
2025/06/14 01:23:49 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_changes-himaqam3
2025/06/14 01:24:50 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/changes/path1'
2025/06/14 01:24:52 NOTICE: checking path2 Local file system at /tmp/011957mu/changes/path2
2025/06/14 01:24:52 NOTICE: [36m(01) :[0m [34mtest changes[0m
2025/06/14 01:24:52 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01: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/check_access
2025/06/14 01:25:05 ERROR : error listing: directory not found
2025/06/14 01:25:05 ERROR : error listing: directory not found
2025/06/14 01:25:05 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_check_access-payodon1
2025/06/14 01:25:48 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/check_access/path1'
2025/06/14 01:25:52 NOTICE: checking path2 Local file system at /tmp/011957mu/check_access/path2
2025/06/14 01:25:52 NOTICE: [36m(01) :[0m [34mtest check-access[0m
2025/06/14 01:25:52 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:25: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/check_access_filters
2025/06/14 01:25:59 ERROR : error listing: directory not found
2025/06/14 01:25:59 ERROR : error listing: directory not found
2025/06/14 01:25:59 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_check_access_filters-kazixus5
2025/06/14 01:28:38 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/check_access_filters/path1'
2025/06/14 01:28:48 NOTICE: checking path2 Local file system at /tmp/011957mu/check_access_filters/path2
2025/06/14 01:28:49 NOTICE: [36m(01) :[0m [34mtest check-access-filters[0m
2025/06/14 01:28:49 NOTICE: [36m(02) :[0m [34mtest EXCLUDE - OTHER TESTS[0m
2025/06/14 01:28:49 NOTICE: [36m(03) :[0m [34mcopy-file /tmp/011957mu/datadir/test_check_access_filters-dodokiz5/exclude-other-filtersfile.txt /tmp/011957mu/workdir/[0m
2025/06/14 01:28:49 NOTICE: [36m(04) :[0m [34mtest resync to get the filters file md5 built.[0m
2025/06/14 01:28:49 NOTICE: [36m(05) :[0m [34mbisync resync filters-file=/tmp/011957mu/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 01:28:57 ERROR : error listing: directory not found
2025/06/14 01:28:57 ERROR : error listing: directory not found
2025/06/14 01:28:57 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_check_filename-cetozaw7
2025/06/14 01:29:48 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/check_filename/path1'
2025/06/14 01:30:00 NOTICE: checking path2 Local file system at /tmp/011957mu/check_filename/path2
2025/06/14 01:30:00 NOTICE: [36m(01) :[0m [34mtest check-filename[0m
2025/06/14 01:30:00 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:30: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/check_sync
2025/06/14 01:30:08 ERROR : error listing: directory not found
2025/06/14 01:30:08 ERROR : error listing: directory not found
2025/06/14 01:30:08 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_check_sync-fazeqaj6
2025/06/14 01:30:59 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/check_sync/path1'
2025/06/14 01:31:00 NOTICE: checking path2 Local file system at /tmp/011957mu/check_sync/path2
2025/06/14 01:31:00 NOTICE: [36m(01) :[0m [34mtest check-sync[0m
2025/06/14 01:31:00 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:31: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/compare_all
2025/06/14 01:31:11 ERROR : error listing: directory not found
2025/06/14 01:31:11 ERROR : error listing: directory not found
2025/06/14 01:31:11 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_compare_all-haroqoh1
2025/06/14 01:32:21 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/compare_all/path1'
2025/06/14 01:32:24 NOTICE: checking path2 Local file system at /tmp/011957mu/compare_all/path2
2025/06/14 01:32:24 NOTICE: [36m(01) :[0m [34mtest changes compare-all[0m
2025/06/14 01:32:24 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:32:24 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 01:32:32 ERROR : error listing: directory not found
2025/06/14 01:32:32 ERROR : error listing: directory not found
2025/06/14 01:32:32 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_concurrent-hidudep5
2025/06/14 01:33:43 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/concurrent/path1'
2025/06/14 01:33:45 NOTICE: checking path2 Local file system at /tmp/011957mu/concurrent/path2
2025/06/14 01:33:45 NOTICE: [36m(01) :[0m [34mtest concurrent[0m
2025/06/14 01:33:45 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:33: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 TestBisyncRemoteLocal/createemptysrcdirs
2025/06/14 01:33:53 ERROR : error listing: directory not found
2025/06/14 01:33:53 ERROR : error listing: directory not found
2025/06/14 01:33:53 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_createemptysrcdirs-midenaw1
2025/06/14 01:34:30 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/createemptysrcdirs/path1'
2025/06/14 01:34:30 NOTICE: checking path2 Local file system at /tmp/011957mu/createemptysrcdirs/path2
2025/06/14 01:34:30 NOTICE: [36m(01) :[0m [34mtest createemptysrcdirs[0m
2025/06/14 01:34:30 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:34:30 NOTICE: [36m(03) :[0m [34mtouch-glob 2001-01-02 /tmp/011957mu/datadir/test_createemptysrcdirs-yajiriw5/ placeholder.txt[0m
2025/06/14 01:34:30 NOTICE: [36m(04) :[0m [34mcopy-as /tmp/011957mu/datadir/test_createemptysrcdirs-yajiriw5/placeholder.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/createemptysrcdirs/path1/ file1.txt[0m
2025/06/14 01:34:39 NOTICE: [36m(05) :[0m [34mcopy-as /tmp/011957mu/datadir/test_createemptysrcdirs-yajiriw5/placeholder.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/createemptysrcdirs/path1/ file1.copy1.txt[0m
2025/06/14 01:34:44 NOTICE: [36m(06) :[0m [34mcopy-as /tmp/011957mu/datadir/test_createemptysrcdirs-yajiriw5/placeholder.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/createemptysrcdirs/path1/ file1.copy2.txt[0m
2025/06/14 01:34:50 NOTICE: [36m(07) :[0m [34mcopy-as /tmp/011957mu/datadir/test_createemptysrcdirs-yajiriw5/placeholder.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/createemptysrcdirs/path1/ file1.copy3.txt[0m
2025/06/14 01:34:57 NOTICE: [36m(08) :[0m [34mcopy-as /tmp/011957mu/datadir/test_createemptysrcdirs-yajiriw5/placeholder.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/createemptysrcdirs/path1/ file1.copy4.txt[0m
2025/06/14 01:35:04 NOTICE: [36m(09) :[0m [34mcopy-as /tmp/011957mu/datadir/test_createemptysrcdirs-yajiriw5/placeholder.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/createemptysrcdirs/path1/ file1.copy5.txt[0m
2025/06/14 01:35:10 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 01:35:17 ERROR : error listing: directory not found
2025/06/14 01:35:17 ERROR : error listing: directory not found
2025/06/14 01:35:17 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_dry_run-natitej1
2025/06/14 01:36:17 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/dry_run/path1'
2025/06/14 01:36:18 NOTICE: checking path2 Local file system at /tmp/011957mu/dry_run/path2
2025/06/14 01:36:18 NOTICE: [36m(01) :[0m [34mtest dry-run[0m
2025/06/14 01:36:18 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:36:18 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 01:36:37 ERROR : error listing: directory not found
2025/06/14 01:36:37 ERROR : error listing: directory not found
2025/06/14 01:36:37 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_equal-payekeg2
2025/06/14 01:36:58 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/equal/path1'
2025/06/14 01:37:00 NOTICE: checking path2 Local file system at /tmp/011957mu/equal/path2
2025/06/14 01:37:00 NOTICE: [36m(01) :[0m [34mtest equal[0m
2025/06/14 01:37:00 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:37: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/ext_paths
2025/06/14 01:37:33 ERROR : error listing: directory not found
2025/06/14 01:37:33 ERROR : error listing: directory not found
2025/06/14 01:37:33 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_ext_paths-xerilux4
2025/06/14 01:38:53 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/ext_paths/path1'
2025/06/14 01:39:01 NOTICE: checking path2 Local file system at /tmp/011957mu/ext_paths/path2
2025/06/14 01:39:02 NOTICE: [36m(01) :[0m [34mtest extended-char-paths[0m
2025/06/14 01:39:02 NOTICE: [36m(02) :[0m [34mfix-names TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/ext_paths/path1/測試Русский{spc}{spc}ěáñ/[0m
2025/06/14 01:40:01 ERROR : premiumize.me root 'rclone-test-rozujam3towu/011957mu/ext_paths/path1/測試Русский ěáñ-rclone-move-siwadax7': Server side directory move failed: directory not found
2025/06/14 01:40:08 ERROR : premiumize.me root 'rclone-test-rozujam3towu/011957mu/ext_paths/path1/測試Русский ěáñ-rclone-move-siwadax7': error reading source root directory: directory not found
2025/06/14 01:40:08 NOTICE: [36m(03) :[0m [34mfix-names /tmp/011957mu/ext_paths/path2/測試Русский{spc}{spc}ěáñ/[0m
2025/06/14 01:40:08 ERROR : Local file system at /tmp/011957mu/ext_paths/path2/測試Русский ěáñ-rclone-move-hecupuv9: Server side directory move failed: rename /tmp/011957mu/ext_paths/path2/測試Русский ěáñ /tmp/011957mu/ext_paths/path2/測試Русский ěáñ-rclone-move-hecupuv9: no such file or directory
2025/06/14 01:40:08 ERROR : Local file system at /tmp/011957mu/ext_paths/path2/測試Русский ěáñ-rclone-move-hecupuv9: error reading source root directory: directory not found
2025/06/14 01:40:08 NOTICE: [36m(04) :[0m [34mfix-names TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 01:40:22 NOTICE: [36m(05) :[0m [34mfix-names /tmp/011957mu/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 01:40:22 NOTICE: [36m(06) :[0m [34mfix-names TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/ext_paths/path1/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt[0m
2025/06/14 01:40:26 NOTICE: [36m(07) :[0m [34mfix-names /tmp/011957mu/ext_paths/path2/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt[0m
2025/06/14 01:40:26 NOTICE: [36m(08) :[0m [34mfix-names TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/ext_paths/path1/測試_check{spc}file[0m
2025/06/14 01:40:32 NOTICE: [36m(09) :[0m [34mfix-names /tmp/011957mu/ext_paths/path2/測試_check{spc}file[0m
2025/06/14 01:40:32 NOTICE: [36m(10) :[0m [34mfix-names TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 01:40:36 NOTICE: [36m(11) :[0m [34mfix-names /tmp/011957mu/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 01:40:36 NOTICE: [36m(12) :[0m [34mtest resync subdirs with extended chars[0m
2025/06/14 01:40:36 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 01:40:44 ERROR : error listing: directory not found
2025/06/14 01:40:44 ERROR : error listing: directory not found
2025/06/14 01:40:44 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_extended_filenames-jusutib0
2025/06/14 01:41:25 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/extended_filenames/path1'
2025/06/14 01:41:27 NOTICE: checking path2 Local file system at /tmp/011957mu/extended_filenames/path2
2025/06/14 01:41:27 NOTICE: [36m(01) :[0m [34mtest extended-filenames[0m
2025/06/14 01:41:27 NOTICE: [36m(02) :[0m [34mfix-names TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/extended_filenames/path1/subdir_with_ࢺ_/[0m
2025/06/14 01:41:27 NOTICE: [36m(03) :[0m [34mfix-names /tmp/011957mu/extended_filenames/path2/subdir_with_ࢺ_/[0m
2025/06/14 01:41:27 NOTICE: [36m(04) :[0m [34mfix-names TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/extended_filenames/path1/subdir_with_ࢺ_/filename_contains_ě_.txt[0m
2025/06/14 01:41:44 NOTICE: [36m(05) :[0m [34mfix-names /tmp/011957mu/extended_filenames/path2/subdir_with_ࢺ_/filename_contains_ě_.txt[0m
2025/06/14 01:41:44 NOTICE: [36m(06) :[0m [34mfix-names TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/extended_filenames/path1/Русский.txt[0m
2025/06/14 01:41:54 NOTICE: [36m(07) :[0m [34mfix-names /tmp/011957mu/extended_filenames/path2/Русский.txt[0m
2025/06/14 01:41:54 NOTICE: [36m(08) :[0m [34mfix-names TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/extended_filenames/path1/file_enconde_mañana_funcionará.txt[0m
2025/06/14 01:41:59 NOTICE: [36m(09) :[0m [34mfix-names /tmp/011957mu/extended_filenames/path2/file_enconde_mañana_funcionará.txt[0m
2025/06/14 01:41:59 NOTICE: [36m(10) :[0m [34mtest initial bisync[0m
2025/06/14 01:41:59 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 01:42:09 ERROR : error listing: directory not found
2025/06/14 01:42:09 ERROR : error listing: directory not found
2025/06/14 01:42:09 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_filters-dacukax7
2025/06/14 01:43:04 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/filters/path1'
2025/06/14 01:43:07 NOTICE: checking path2 Local file system at /tmp/011957mu/filters/path2
2025/06/14 01:43:07 NOTICE: [36m(01) :[0m [34mtest filters[0m
2025/06/14 01:43:07 NOTICE: [36m(02) :[0m [34mcopy-file /tmp/011957mu/datadir/test_filters-kenopeh5/filtersfile.flt /tmp/011957mu/workdir/[0m
2025/06/14 01:43:07 NOTICE: [36m(03) :[0m [34mtest resync to force building of the filters md5 hash[0m
2025/06/14 01:43:07 NOTICE: [36m(04) :[0m [34mbisync filters-file=/tmp/011957mu/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 01:43:18 ERROR : error listing: directory not found
2025/06/14 01:43:18 ERROR : error listing: directory not found
2025/06/14 01:43:18 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_filtersfile_checks-fuhetik5
2025/06/14 01:43:47 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/filtersfile_checks/path1'
2025/06/14 01:43:50 NOTICE: checking path2 Local file system at /tmp/011957mu/filtersfile_checks/path2
2025/06/14 01:43:50 NOTICE: [36m(01) :[0m [34mtest filtersfile-checks[0m
2025/06/14 01:43:50 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:43:50 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 01:44:47 ERROR : error listing: directory not found
2025/06/14 01:44:47 ERROR : error listing: directory not found
2025/06/14 01:44:47 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_ignorelistingchecksum-manesor4
2025/06/14 01:45:37 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/ignorelistingchecksum/path1'
2025/06/14 01:45:39 NOTICE: checking path2 Local file system at /tmp/011957mu/ignorelistingchecksum/path2
2025/06/14 01:45:39 NOTICE: [36m(01) :[0m [34mtest basic[0m
2025/06/14 01:45:39 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:45:39 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 01:45:48 ERROR : error listing: directory not found
2025/06/14 01:45:48 ERROR : error listing: directory not found
2025/06/14 01:45:48 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_max_delete_path1-dehaxeq0
2025/06/14 01:47:02 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/max_delete_path1/path1'
2025/06/14 01:47:04 NOTICE: checking path2 Local file system at /tmp/011957mu/max_delete_path1/path2
2025/06/14 01:47:04 NOTICE: [36m(01) :[0m [34mtest max-delete-path1[0m
2025/06/14 01:47:04 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:47:04 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 01:47:30 ERROR : error listing: directory not found
2025/06/14 01:47:30 ERROR : error listing: directory not found
2025/06/14 01:47:30 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_max_delete_path2_force-huwojog6
2025/06/14 01:48:36 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/max_delete_path2_force/path1'
2025/06/14 01:48:37 NOTICE: checking path2 Local file system at /tmp/011957mu/max_delete_path2_force/path2
2025/06/14 01:48:37 NOTICE: [36m(01) :[0m [34mtest max-delete-path2-force[0m
2025/06/14 01:48:37 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:48:37 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 01:48:50 ERROR : error listing: directory not found
2025/06/14 01:48:50 ERROR : error listing: directory not found
2025/06/14 01:48:50 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_nomodtime-kafugos5
2025/06/14 01:50:16 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/nomodtime/path1'
2025/06/14 01:50:17 NOTICE: checking path2 Local file system at /tmp/011957mu/nomodtime/path2
2025/06/14 01:50:17 NOTICE: [36m(01) :[0m [34mtest changes[0m
2025/06/14 01:50:17 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:50:17 NOTICE: [36m(03) :[0m [34mbisync resync nomodtime[0m
2025/06/14 01:50:22 NOTICE: Local file system at /tmp/011957mu/nomodtime/path2: [33mwill use md5 for same-side diffs on Path2 only[0m
2025/06/14 01:50:22 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 01:50:22 INFO : Synching Path1 "TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/" with Path2 "/tmp/011957mu/nomodtime/path2/"
2025/06/14 01:50:22 INFO : Copying Path2 files to Path1
2025/06/14 01:50:22 INFO : - [34mPath2[0m [35mResync is copying files to[0m - [36mPath1[0m
2025/06/14 01:50:23 INFO : TestPremiumizeMe: [2mDownloading hashes...[0m
2025/06/14 01:50:26 INFO : - [36mPath1[0m [35mResync is copying files to[0m - [36mPath2[0m
2025/06/14 01:50:27 INFO : Resync updating listings
2025/06/14 01:50:27 INFO : Validating listings for Path1 "TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/" vs Path2 "/tmp/011957mu/nomodtime/path2/"
2025/06/14 01:50:27 INFO : [32mBisync successful[0m
2025/06/14 01:50:27 NOTICE: [36m(04) :[0m [34mtest make modifications on both paths[0m
2025/06/14 01:50:27 NOTICE: [36m(05) :[0m [34mtest new on path2 - file10[0m
2025/06/14 01:50:27 NOTICE: [36m(06) :[0m [34mcopy-file /tmp/011957mu/datadir/test_nomodtime-vufunaw9/file10.txt /tmp/011957mu/nomodtime/path2/[0m
2025/06/14 01:50:27 NOTICE: [36m(07) :[0m [34mtest changed on path2 - file1[0m
2025/06/14 01:50:27 NOTICE: [36m(08) :[0m [34mcopy-file /tmp/011957mu/datadir/test_nomodtime-vufunaw9/file1.txt /tmp/011957mu/nomodtime/path2/[0m
2025/06/14 01:50:27 NOTICE: [36m(09) :[0m [34mtest new on path1 - file11[0m
2025/06/14 01:50:27 NOTICE: [36m(10) :[0m [34mcopy-file /tmp/011957mu/datadir/test_nomodtime-vufunaw9/file11.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/[0m
2025/06/14 01:50:40 NOTICE: [36m(11) :[0m [34mtest changed on path1 - file2[0m
2025/06/14 01:50:40 NOTICE: [36m(12) :[0m [34mcopy-file /tmp/011957mu/datadir/test_nomodtime-vufunaw9/file2.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/[0m
2025/06/14 01:50:49 NOTICE: [36m(13) :[0m [34mtest deleted on path2 - file3[0m
2025/06/14 01:50:49 NOTICE: [36m(14) :[0m [34mdelete-file /tmp/011957mu/nomodtime/path2/file3.txt[0m
2025/06/14 01:50:49 NOTICE: [36m(15) :[0m [34mtest deleted on path1 - file4[0m
2025/06/14 01:50:49 NOTICE: [36m(16) :[0m [34mdelete-file TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/file4.txt[0m
2025/06/14 01:50:55 NOTICE: [36m(17) :[0m [34mtest deleted on both paths - file8[0m
2025/06/14 01:50:55 NOTICE: [36m(18) :[0m [34mdelete-file TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/file8.txt[0m
2025/06/14 01:50:59 NOTICE: [36m(19) :[0m [34mdelete-file /tmp/011957mu/nomodtime/path2/file8.txt[0m
2025/06/14 01:50:59 NOTICE: [36m(20) :[0m [34mtest changed on both paths - file5 (file5R, file5L)[0m
2025/06/14 01:50:59 NOTICE: [36m(21) :[0m [34mcopy-as /tmp/011957mu/datadir/test_nomodtime-vufunaw9/file5R.txt /tmp/011957mu/nomodtime/path2/ file5.txt[0m
2025/06/14 01:50:59 NOTICE: [36m(22) :[0m [34mcopy-as /tmp/011957mu/datadir/test_nomodtime-vufunaw9/file5L.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/ file5.txt[0m
2025/06/14 01:51:09 NOTICE: [36m(23) :[0m [34mtest changed on path2 and deleted on path1 - file6[0m
2025/06/14 01:51:09 NOTICE: [36m(24) :[0m [34mcopy-file /tmp/011957mu/datadir/test_nomodtime-vufunaw9/file6.txt /tmp/011957mu/nomodtime/path2/[0m
2025/06/14 01:51:09 NOTICE: [36m(25) :[0m [34mdelete-file TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/file6.txt[0m
2025/06/14 01:51:13 NOTICE: [36m(26) :[0m [34mtest changed on path1 and deleted on path2 - file7[0m
2025/06/14 01:51:13 NOTICE: [36m(27) :[0m [34mcopy-file /tmp/011957mu/datadir/test_nomodtime-vufunaw9/file7.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/[0m
2025/06/14 01:51:21 NOTICE: [36m(28) :[0m [34mdelete-file /tmp/011957mu/nomodtime/path2/file7.txt[0m
2025/06/14 01:51:21 NOTICE: [36m(29) :[0m [34mtest bisync run[0m
2025/06/14 01:51:21 NOTICE: [36m(30) :[0m [34mbisync nomodtime[0m
2025/06/14 01:51:28 NOTICE: Local file system at /tmp/011957mu/nomodtime/path2: [33mwill use md5 for same-side diffs on Path2 only[0m
2025/06/14 01:51:28 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 01:51:28 INFO : Synching Path1 "TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/" with Path2 "/tmp/011957mu/nomodtime/path2/"
2025/06/14 01:51:28 INFO : Building Path1 and Path2 listings
2025/06/14 01:51:29 INFO : TestPremiumizeMe: [2mDownloading hashes...[0m
2025/06/14 01:51:32 INFO : Path1 checking for diffs
2025/06/14 01:51:32 INFO : - [36mPath1[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile2.txt[0m
2025/06/14 01:51:32 INFO : - [36mPath1[0m [35m[31mFile was deleted[0m[0m - [36mfile4.txt[0m
2025/06/14 01:51:32 INFO : - [36mPath1[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile5.txt[0m
2025/06/14 01:51:32 INFO : - [36mPath1[0m [35m[31mFile was deleted[0m[0m - [36mfile6.txt[0m
2025/06/14 01:51:32 INFO : - [36mPath1[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile7.txt[0m
2025/06/14 01:51:32 INFO : - [36mPath1[0m [35m[31mFile was deleted[0m[0m - [36mfile8.txt[0m
2025/06/14 01:51:32 INFO : - [36mPath1[0m [35m[32mFile is new[0m[0m - [36mfile11.txt[0m
2025/06/14 01:51:32 INFO : Path1: 7 changes: [32m 1 new[0m, [33m 3 modified[0m, [31m 3 deleted[0m
2025/06/14 01:51:32 INFO : ([33mModified[0m: [36m 3 larger[0m, [34m 0 smaller[0m, [36m 3 hash differs[0m)
2025/06/14 01:51:32 INFO : Path2 checking for diffs
2025/06/14 01:51:32 INFO : - [34mPath2[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile1.txt[0m
2025/06/14 01:51:32 INFO : - [34mPath2[0m [35m[31mFile was deleted[0m[0m - [36mfile3.txt[0m
2025/06/14 01:51:32 INFO : - [34mPath2[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile5.txt[0m
2025/06/14 01:51:32 INFO : - [34mPath2[0m [35m[33mFile changed: [35msize (larger)[0m, [35mhash[0m[0m[0m - [36mfile6.txt[0m
2025/06/14 01:51:32 INFO : - [34mPath2[0m [35m[31mFile was deleted[0m[0m - [36mfile7.txt[0m
2025/06/14 01:51:32 INFO : - [34mPath2[0m [35m[31mFile was deleted[0m[0m - [36mfile8.txt[0m
2025/06/14 01:51:32 INFO : - [34mPath2[0m [35m[32mFile is new[0m[0m - [36mfile10.txt[0m
2025/06/14 01:51:32 INFO : Path2: 7 changes: [32m 1 new[0m, [33m 3 modified[0m, [31m 3 deleted[0m
2025/06/14 01:51:32 INFO : ([33mModified[0m: [36m 3 larger[0m, [34m 0 smaller[0m, [36m 3 hash differs[0m)
2025/06/14 01:51:32 INFO : Applying changes
2025/06/14 01:51:32 INFO : - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36m/tmp/011957mu/nomodtime/path2/file11.txt[0m
2025/06/14 01:51:32 INFO : - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36m/tmp/011957mu/nomodtime/path2/file2.txt[0m
2025/06/14 01:51:32 INFO : - [34mPath2[0m [35m[31mQueue delete[0m[0m - [36m/tmp/011957mu/nomodtime/path2/file4.txt[0m
2025/06/14 01:51:32 NOTICE: - [34mWARNING[0m [35mNew or changed in both paths[0m - [36mfile5.txt[0m
2025/06/14 01:51:32 NOTICE: - [36mPath1[0m [35mRenaming Path1 copy[0m - [36mTestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/file5.txt.conflict1[0m
2025/06/14 01:51:39 INFO : file5.txt: Moved (server-side) to: file5.txt.conflict1
2025/06/14 01:51:39 NOTICE: - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36m/tmp/011957mu/nomodtime/path2/file5.txt.conflict1[0m
2025/06/14 01:51:39 NOTICE: - [34mPath2[0m [35mRenaming Path2 copy[0m - [36m/tmp/011957mu/nomodtime/path2/file5.txt.conflict2[0m
2025/06/14 01:51:39 INFO : file5.txt: Moved (server-side) to: file5.txt.conflict2
2025/06/14 01:51:39 NOTICE: - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36mTestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/file5.txt.conflict2[0m
2025/06/14 01:51:39 INFO : - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36mTestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/file6.txt[0m
2025/06/14 01:51:39 INFO : - [36mPath1[0m [35m[32mQueue copy to[0m Path2[0m - [36m/tmp/011957mu/nomodtime/path2/file7.txt[0m
2025/06/14 01:51:39 INFO : - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36mTestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/file1.txt[0m
2025/06/14 01:51:39 INFO : - [34mPath2[0m [35m[32mQueue copy to[0m Path1[0m - [36mTestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/file10.txt[0m
2025/06/14 01:51:39 INFO : - [36mPath1[0m [35m[31mQueue delete[0m[0m - [36mTestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/file3.txt[0m
2025/06/14 01:51:39 INFO : - [34mPath2[0m [35mDo queued copies to[0m - [36mPath1[0m
2025/06/14 01:51:53 INFO : file5.txt.conflict2: Copied (new)
2025/06/14 01:51:55 INFO : file6.txt: Copied (new)
2025/06/14 01:51:56 INFO : file10.txt: Copied (new)
2025/06/14 01:51:58 INFO : file1.txt: Copied (replaced existing)
2025/06/14 01:51:59 INFO : file3.txt: Deleted
2025/06/14 01:51:59 INFO : - [36mPath1[0m [35mDo queued copies to[0m - [36mPath2[0m
2025/06/14 01:52:00 INFO : file11.txt: Copied (new)
2025/06/14 01:52:01 INFO : file5.txt.conflict1: Copied (new)
2025/06/14 01:52:01 INFO : file7.txt: Copied (new)
2025/06/14 01:52:01 INFO : file2.txt: Copied (replaced existing)
2025/06/14 01:52:01 INFO : file4.txt: Deleted
2025/06/14 01:52:01 INFO : Updating listings
2025/06/14 01:52:01 INFO : Validating listings for Path1 "TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/nomodtime/path1/" vs Path2 "/tmp/011957mu/nomodtime/path2/"
2025/06/14 01:52:01 INFO : [32mBisync successful[0m
bisync_test.go:560: [32mTEST nomodtime PASSED[0m
=== RUN TestBisyncRemoteLocal/normalization
2025/06/14 01:52:08 ERROR : error listing: directory not found
2025/06/14 01:52:08 ERROR : error listing: directory not found
2025/06/14 01:52:08 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_normalization-mivocul7
2025/06/14 01:52:37 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/normalization/path1'
2025/06/14 01:52:50 NOTICE: checking path2 Local file system at /tmp/011957mu/normalization/path2
2025/06/14 01:52:50 NOTICE: [36m(01) :[0m [34mtest normalization[0m
2025/06/14 01:52:50 NOTICE: [36m(02) :[0m [34mtouch-copy 2001-01-02 /tmp/011957mu/datadir/test_normalization-farehus8/file1.txt /tmp/011957mu/normalization/path2/[0m
2025/06/14 01:52:50 NOTICE: [36m(03) :[0m [34mtest initial bisync[0m
2025/06/14 01:52:50 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 01:52:57 ERROR : error listing: directory not found
2025/06/14 01:52:57 ERROR : error listing: directory not found
2025/06/14 01:52:57 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_rclone_args-wawijas8
2025/06/14 01:53:22 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/rclone_args/path1'
2025/06/14 01:53:25 NOTICE: checking path2 Local file system at /tmp/011957mu/rclone_args/path2
2025/06/14 01:53:25 NOTICE: [36m(01) :[0m [34mtest rclone-args[0m
2025/06/14 01:53:25 NOTICE: [36m(02) :[0m [34mtouch-glob 2001-01-02 /tmp/011957mu/datadir/test_rclone_args-molawah6/ *[0m
2025/06/14 01:53:25 NOTICE: [36m(03) :[0m [34mtest initial bisync[0m
2025/06/14 01:53:25 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 01:53:32 ERROR : error listing: directory not found
2025/06/14 01:53:32 ERROR : error listing: directory not found
2025/06/14 01:53:32 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_resolve-fayasat0
2025/06/14 01:53:47 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/resolve/path1'
2025/06/14 01:53:48 NOTICE: checking path2 Local file system at /tmp/011957mu/resolve/path2
2025/06/14 01:53:48 NOTICE: [36m(01) :[0m [34mtest resolve[0m
2025/06/14 01:53:48 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:53:48 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 01:53:59 ERROR : error listing: directory not found
2025/06/14 01:53:59 ERROR : error listing: directory not found
2025/06/14 01:53:59 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_resync-webifot7
2025/06/14 01:54:32 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/resync/path1'
2025/06/14 01:54:33 NOTICE: checking path2 Local file system at /tmp/011957mu/resync/path2
2025/06/14 01:54:33 NOTICE: [36m(01) :[0m [34mtest resync[0m
2025/06/14 01:54:33 NOTICE: [36m(02) :[0m [34mtest 1. resync with empty path1, resulting in copying all content from path2.[0m
2025/06/14 01:54:33 NOTICE: [36m(03) :[0m [34mpurge-children TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/resync/path1/[0m
2025/06/14 01:54:42 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 01:54:50 ERROR : error listing: directory not found
2025/06/14 01:54:50 ERROR : error listing: directory not found
2025/06/14 01:54:50 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_resync_modes-ditabut2
2025/06/14 01:55:04 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/resync_modes/path1'
2025/06/14 01:55:06 NOTICE: checking path2 Local file system at /tmp/011957mu/resync_modes/path2
2025/06/14 01:55:06 NOTICE: [36m(01) :[0m [34mtest resync-mode[0m
2025/06/14 01:55:06 NOTICE: [36m(02) :[0m [34mtest changed on both paths and NOT identical - file1 (file1R, file1L)[0m
2025/06/14 01:55:06 NOTICE: [36m(03) :[0m [34mtouch-glob 2001-01-02 /tmp/011957mu/datadir/test_resync_modes-jevexis4/ file1R.txt[0m
2025/06/14 01:55:06 NOTICE: [36m(04) :[0m [34mcopy-as /tmp/011957mu/datadir/test_resync_modes-jevexis4/file1R.txt /tmp/011957mu/resync_modes/path2/ file1.txt[0m
2025/06/14 01:55:06 NOTICE: [36m(05) :[0m [34mtouch-glob 2001-03-04 /tmp/011957mu/datadir/test_resync_modes-jevexis4/ file1L.txt[0m
2025/06/14 01:55:06 NOTICE: [36m(06) :[0m [34mcopy-as /tmp/011957mu/datadir/test_resync_modes-jevexis4/file1L.txt TestPremiumizeMe:rclone-test-rozujam3towu/011957mu/resync_modes/path1/ file1.txt[0m
2025/06/14 01:55:15 NOTICE: [36m(07) :[0m [34mtest bisync run with --resync-mode=newer[0m
2025/06/14 01:55:15 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 01:55:26 ERROR : error listing: directory not found
2025/06/14 01:55:26 ERROR : error listing: directory not found
2025/06/14 01:55:26 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_rmdirs-dalebeq1
2025/06/14 01:56:07 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/rmdirs/path1'
2025/06/14 01:56:08 NOTICE: checking path2 Local file system at /tmp/011957mu/rmdirs/path2
2025/06/14 01:56:08 NOTICE: [36m(01) :[0m [34mtest rmdirs[0m
2025/06/14 01:56:08 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:56: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/volatile
2025/06/14 01:56:33 ERROR : error listing: directory not found
2025/06/14 01:56:33 ERROR : error listing: directory not found
2025/06/14 01:56:33 NOTICE: checking initFs Local file system at /tmp/011957mu/initdir/test_volatile-xunohem8
2025/06/14 01:57:25 NOTICE: checking Path1 premiumize.me root 'rclone-test-rozujam3towu/011957mu/volatile/path1'
2025/06/14 01:57:27 NOTICE: checking path2 Local file system at /tmp/011957mu/volatile/path2
2025/06/14 01:57:27 NOTICE: [36m(01) :[0m [34mtest volatile[0m
2025/06/14 01:57:27 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:57:27 NOTICE: [36m(03) :[0m [34mbisync resync[0m
bisync_test.go:937: skipping 'volatile' test on non-local as it requires uploading 100 files
--- PASS: TestBisyncRemoteLocal (2256.97s)
--- SKIP: TestBisyncRemoteLocal/all_changed (91.73s)
--- SKIP: TestBisyncRemoteLocal/backupdir (64.97s)
--- SKIP: TestBisyncRemoteLocal/basic (64.86s)
--- SKIP: TestBisyncRemoteLocal/changes (73.83s)
--- SKIP: TestBisyncRemoteLocal/check_access (59.29s)
--- SKIP: TestBisyncRemoteLocal/check_access_filters (176.93s)
--- SKIP: TestBisyncRemoteLocal/check_filename (71.02s)
--- SKIP: TestBisyncRemoteLocal/check_sync (60.66s)
--- SKIP: TestBisyncRemoteLocal/compare_all (84.08s)
--- SKIP: TestBisyncRemoteLocal/concurrent (81.03s)
--- SKIP: TestBisyncRemoteLocal/createemptysrcdirs (84.36s)
--- SKIP: TestBisyncRemoteLocal/dry_run (68.81s)
--- SKIP: TestBisyncRemoteLocal/equal (41.70s)
--- SKIP: TestBisyncRemoteLocal/ext_paths (216.09s)
--- SKIP: TestBisyncRemoteLocal/extended_filenames (83.18s)
--- SKIP: TestBisyncRemoteLocal/filters (68.05s)
--- SKIP: TestBisyncRemoteLocal/filtersfile_checks (42.71s)
--- SKIP: TestBisyncRemoteLocal/ignorelistingchecksum (108.93s)
--- SKIP: TestBisyncRemoteLocal/max_delete_path1 (84.62s)
--- SKIP: TestBisyncRemoteLocal/max_delete_path2_force (93.50s)
--- PASS: TestBisyncRemoteLocal/nomodtime (204.06s)
--- SKIP: TestBisyncRemoteLocal/normalization (48.40s)
--- SKIP: TestBisyncRemoteLocal/rclone_args (34.90s)
--- SKIP: TestBisyncRemoteLocal/resolve (23.81s)
--- SKIP: TestBisyncRemoteLocal/resync (53.82s)
--- SKIP: TestBisyncRemoteLocal/resync_modes (33.00s)
--- SKIP: TestBisyncRemoteLocal/rmdirs (52.85s)
--- SKIP: TestBisyncRemoteLocal/volatile (78.56s)
=== RUN TestBisyncLocalRemote
2025/06/14 01:57:43 NOTICE: remote: TestPremiumizeMe:rclone-test-cenuzeb4zoko
=== RUN TestBisyncLocalRemote/all_changed
2025/06/14 01:58:04 ERROR : error listing: directory not found
2025/06/14 01:58:17 ERROR : error listing: directory not found
2025/06/14 01:58:17 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_all_changed-pazecex6
2025/06/14 01:58:17 NOTICE: checking Path1 Local file system at /tmp/015743so/all_changed/path1
2025/06/14 01:59:19 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/all_changed/path2'
2025/06/14 01:59:21 NOTICE: [36m(01) :[0m [34mtest all-changed[0m
2025/06/14 01:59:21 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 01:59:21 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 01:59:28 ERROR : error listing: directory not found
2025/06/14 01:59:29 ERROR : error listing: directory not found
2025/06/14 01:59:29 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_backupdir-tapiwiz2
2025/06/14 01:59:29 NOTICE: checking Path1 Local file system at /tmp/015743so/backupdir/path1
2025/06/14 02:00:21 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/backupdir/path2'
2025/06/14 02:00:22 NOTICE: [36m(01) :[0m [34mtest backupdir[0m
2025/06/14 02:00:22 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:00:22 NOTICE: [36m(03) :[0m [34mbisync resync backupdir1=/tmp/015743so/workdir/backupdirs/backupdir1 backupdir2=/tmp/015743so/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:00:57 ERROR : error listing: directory not found
2025/06/14 02:01:03 ERROR : error listing: directory not found
2025/06/14 02:01:03 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_basic-zokeqag0
2025/06/14 02:01:03 NOTICE: checking Path1 Local file system at /tmp/015743so/basic/path1
2025/06/14 02:02:11 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/basic/path2'
2025/06/14 02:02:15 NOTICE: [36m(01) :[0m [34mtest basic[0m
2025/06/14 02:02:15 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:02:15 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:02:26 ERROR : error listing: directory not found
2025/06/14 02:02:35 ERROR : error listing: directory not found
2025/06/14 02:02:35 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_changes-bewuvaf5
2025/06/14 02:02:35 NOTICE: checking Path1 Local file system at /tmp/015743so/changes/path1
2025/06/14 02:03:25 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/changes/path2'
2025/06/14 02:03:27 NOTICE: [36m(01) :[0m [34mtest changes[0m
2025/06/14 02:03:27 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:03:27 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:03:34 ERROR : error listing: directory not found
2025/06/14 02:03:35 ERROR : error listing: directory not found
2025/06/14 02:03:35 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_check_access-cocikic5
2025/06/14 02:03:35 NOTICE: checking Path1 Local file system at /tmp/015743so/check_access/path1
2025/06/14 02:04:12 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/check_access/path2'
2025/06/14 02:04:14 NOTICE: [36m(01) :[0m [34mtest check-access[0m
2025/06/14 02:04:14 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:04:14 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:04:21 ERROR : error listing: directory not found
2025/06/14 02:04:23 ERROR : error listing: directory not found
2025/06/14 02:04:23 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_check_access_filters-beyiwox4
2025/06/14 02:04:23 NOTICE: checking Path1 Local file system at /tmp/015743so/check_access_filters/path1
2025/06/14 02:06:08 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/check_access_filters/path2'
2025/06/14 02:06:16 NOTICE: [36m(01) :[0m [34mtest check-access-filters[0m
2025/06/14 02:06:16 NOTICE: [36m(02) :[0m [34mtest EXCLUDE - OTHER TESTS[0m
2025/06/14 02:06:16 NOTICE: [36m(03) :[0m [34mcopy-file /tmp/015743so/datadir/test_check_access_filters-perosox7/exclude-other-filtersfile.txt /tmp/015743so/workdir/[0m
2025/06/14 02:06:16 NOTICE: [36m(04) :[0m [34mtest resync to get the filters file md5 built.[0m
2025/06/14 02:06:16 NOTICE: [36m(05) :[0m [34mbisync resync filters-file=/tmp/015743so/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:06:22 ERROR : error listing: directory not found
2025/06/14 02:06:23 ERROR : error listing: directory not found
2025/06/14 02:06:23 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_check_filename-xiwoyek5
2025/06/14 02:06:23 NOTICE: checking Path1 Local file system at /tmp/015743so/check_filename/path1
2025/06/14 02:06:58 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/check_filename/path2'
2025/06/14 02:07:03 NOTICE: [36m(01) :[0m [34mtest check-filename[0m
2025/06/14 02:07:03 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:07: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/check_sync
2025/06/14 02:07:11 ERROR : error listing: directory not found
2025/06/14 02:07:11 ERROR : error listing: directory not found
2025/06/14 02:07:11 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_check_sync-wucuyos7
2025/06/14 02:07:11 NOTICE: checking Path1 Local file system at /tmp/015743so/check_sync/path1
2025/06/14 02:08:03 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/check_sync/path2'
2025/06/14 02:08:05 NOTICE: [36m(01) :[0m [34mtest check-sync[0m
2025/06/14 02:08:05 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:08:05 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:08:12 ERROR : error listing: directory not found
2025/06/14 02:08:15 ERROR : error listing: directory not found
2025/06/14 02:08:15 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_compare_all-jewulax4
2025/06/14 02:08:15 NOTICE: checking Path1 Local file system at /tmp/015743so/compare_all/path1
2025/06/14 02:08:56 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/compare_all/path2'
2025/06/14 02:08:56 NOTICE: [36m(01) :[0m [34mtest changes compare-all[0m
2025/06/14 02:08:56 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:08:56 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 02:09:09 ERROR : error listing: directory not found
2025/06/14 02:09:10 ERROR : error listing: directory not found
2025/06/14 02:09:10 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_concurrent-cozofib9
2025/06/14 02:09:10 NOTICE: checking Path1 Local file system at /tmp/015743so/concurrent/path1
2025/06/14 02:10:13 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/concurrent/path2'
2025/06/14 02:10:14 NOTICE: [36m(01) :[0m [34mtest concurrent[0m
2025/06/14 02:10:14 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:10:14 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 02:10:36 ERROR : error listing: directory not found
2025/06/14 02:10:38 ERROR : error listing: directory not found
2025/06/14 02:10:38 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_createemptysrcdirs-ceqagug9
2025/06/14 02:10:38 NOTICE: checking Path1 Local file system at /tmp/015743so/createemptysrcdirs/path1
2025/06/14 02:11:38 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/createemptysrcdirs/path2'
2025/06/14 02:11:40 NOTICE: [36m(01) :[0m [34mtest createemptysrcdirs[0m
2025/06/14 02:11:40 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:11:40 NOTICE: [36m(03) :[0m [34mtouch-glob 2001-01-02 /tmp/015743so/datadir/test_createemptysrcdirs-zajasaw4/ placeholder.txt[0m
2025/06/14 02:11:40 NOTICE: [36m(04) :[0m [34mcopy-as /tmp/015743so/datadir/test_createemptysrcdirs-zajasaw4/placeholder.txt /tmp/015743so/createemptysrcdirs/path1/ file1.txt[0m
2025/06/14 02:11:40 NOTICE: [36m(05) :[0m [34mcopy-as /tmp/015743so/datadir/test_createemptysrcdirs-zajasaw4/placeholder.txt /tmp/015743so/createemptysrcdirs/path1/ file1.copy1.txt[0m
2025/06/14 02:11:40 NOTICE: [36m(06) :[0m [34mcopy-as /tmp/015743so/datadir/test_createemptysrcdirs-zajasaw4/placeholder.txt /tmp/015743so/createemptysrcdirs/path1/ file1.copy2.txt[0m
2025/06/14 02:11:40 NOTICE: [36m(07) :[0m [34mcopy-as /tmp/015743so/datadir/test_createemptysrcdirs-zajasaw4/placeholder.txt /tmp/015743so/createemptysrcdirs/path1/ file1.copy3.txt[0m
2025/06/14 02:11:40 NOTICE: [36m(08) :[0m [34mcopy-as /tmp/015743so/datadir/test_createemptysrcdirs-zajasaw4/placeholder.txt /tmp/015743so/createemptysrcdirs/path1/ file1.copy4.txt[0m
2025/06/14 02:11:40 NOTICE: [36m(09) :[0m [34mcopy-as /tmp/015743so/datadir/test_createemptysrcdirs-zajasaw4/placeholder.txt /tmp/015743so/createemptysrcdirs/path1/ file1.copy5.txt[0m
2025/06/14 02:11:40 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 02:11:55 ERROR : error listing: directory not found
2025/06/14 02:11:58 ERROR : error listing: directory not found
2025/06/14 02:11:58 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_dry_run-hugegiq9
2025/06/14 02:11:58 NOTICE: checking Path1 Local file system at /tmp/015743so/dry_run/path1
2025/06/14 02:13:05 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/dry_run/path2'
2025/06/14 02:13:06 NOTICE: [36m(01) :[0m [34mtest dry-run[0m
2025/06/14 02:13:06 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:13: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/equal
2025/06/14 02:13:15 ERROR : error listing: directory not found
2025/06/14 02:13:18 ERROR : error listing: directory not found
2025/06/14 02:13:18 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_equal-navumux6
2025/06/14 02:13:18 NOTICE: checking Path1 Local file system at /tmp/015743so/equal/path1
2025/06/14 02:14:09 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/equal/path2'
2025/06/14 02:14:09 NOTICE: [36m(01) :[0m [34mtest equal[0m
2025/06/14 02:14:09 NOTICE: [36m(02) :[0m [34mtest initial bisync[0m
2025/06/14 02:14:09 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 02:14:16 ERROR : error listing: directory not found
2025/06/14 02:14:17 ERROR : error listing: directory not found
2025/06/14 02:14:17 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_ext_paths-hozaxup5
2025/06/14 02:14:17 NOTICE: checking Path1 Local file system at /tmp/015743so/ext_paths/path1
2025/06/14 02:15:20 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/ext_paths/path2'
2025/06/14 02:15:21 NOTICE: [36m(01) :[0m [34mtest extended-char-paths[0m
2025/06/14 02:15:21 NOTICE: [36m(02) :[0m [34mfix-names /tmp/015743so/ext_paths/path1/測試Русский{spc}{spc}ěáñ/[0m
2025/06/14 02:15:21 ERROR : Local file system at /tmp/015743so/ext_paths/path1/測試Русский ěáñ-rclone-move-yikibuc2: Server side directory move failed: rename /tmp/015743so/ext_paths/path1/測試Русский ěáñ /tmp/015743so/ext_paths/path1/測試Русский ěáñ-rclone-move-yikibuc2: no such file or directory
2025/06/14 02:15:21 ERROR : Local file system at /tmp/015743so/ext_paths/path1/測試Русский ěáñ-rclone-move-yikibuc2: error reading source root directory: directory not found
2025/06/14 02:15:21 NOTICE: [36m(03) :[0m [34mfix-names TestPremiumizeMe:rclone-test-cenuzeb4zoko/015743so/ext_paths/path2/測試Русский{spc}{spc}ěáñ/[0m
2025/06/14 02:16:04 ERROR : premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/ext_paths/path2/測試Русский ěáñ-rclone-move-diyeriq2': Server side directory move failed: couldn't list files: 503 Service Unavailable (503):
503 Service Temporarily Unavailable
503 Service Temporarily Unavailable
nginx/1.18.0 (Ubuntu)
2025/06/14 02:16:12 ERROR : premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/ext_paths/path2/測試Русский ěáñ-rclone-move-diyeriq2': error reading source root directory: directory not found
2025/06/14 02:16:12 NOTICE: [36m(04) :[0m [34mfix-names /tmp/015743so/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 02:16:12 NOTICE: [36m(05) :[0m [34mfix-names TestPremiumizeMe:rclone-test-cenuzeb4zoko/015743so/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 02:16:22 NOTICE: [36m(06) :[0m [34mfix-names /tmp/015743so/ext_paths/path1/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt[0m
2025/06/14 02:16:22 NOTICE: [36m(07) :[0m [34mfix-names TestPremiumizeMe:rclone-test-cenuzeb4zoko/015743so/ext_paths/path2/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt[0m
2025/06/14 02:16:30 NOTICE: [36m(08) :[0m [34mfix-names /tmp/015743so/ext_paths/path1/測試_check{spc}file[0m
2025/06/14 02:16:30 NOTICE: [36m(09) :[0m [34mfix-names TestPremiumizeMe:rclone-test-cenuzeb4zoko/015743so/ext_paths/path2/測試_check{spc}file[0m
2025/06/14 02:16:34 NOTICE: [36m(10) :[0m [34mfix-names /tmp/015743so/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 02:16:34 NOTICE: [36m(11) :[0m [34mfix-names TestPremiumizeMe:rclone-test-cenuzeb4zoko/015743so/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file[0m
2025/06/14 02:16:39 NOTICE: [36m(12) :[0m [34mtest resync subdirs with extended chars[0m
2025/06/14 02:16:39 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 02:16:46 ERROR : error listing: directory not found
2025/06/14 02:16:48 ERROR : error listing: directory not found
2025/06/14 02:16:48 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_extended_filenames-xewegic2
2025/06/14 02:16:48 NOTICE: checking Path1 Local file system at /tmp/015743so/extended_filenames/path1
2025/06/14 02:18:04 NOTICE: checking path2 premiumize.me root 'rclone-test-cenuzeb4zoko/015743so/extended_filenames/path2'
2025/06/14 02:18:11 NOTICE: [36m(01) :[0m [34mtest extended-filenames[0m
2025/06/14 02:18:11 NOTICE: [36m(02) :[0m [34mfix-names /tmp/015743so/extended_filenames/path1/subdir_with_ࢺ_/[0m
2025/06/14 02:18:11 NOTICE: [36m(03) :[0m [34mfix-names TestPremiumizeMe:rclone-test-cenuzeb4zoko/015743so/extended_filenames/path2/subdir_with_ࢺ_/[0m
2025/06/14 02:18:11 NOTICE: [36m(04) :[0m [34mfix-names /tmp/015743so/extended_filenames/path1/subdir_with_ࢺ_/filename_contains_ě_.txt[0m
2025/06/14 02:18:11 NOTICE: [36m(05) :[0m [34mfix-names TestPremiumizeMe:rclone-test-cenuzeb4zoko/015743so/extended_filenames/path2/subdir_with_ࢺ_/filename_contains_ě_.txt[0m
2025/06/14 02:18:57 NOTICE: [36m(06) :[0m [34mfix-names /tmp/015743so/extended_filenames/path1/Русский.txt[0m
2025/06/14 02:18:57 NOTICE: [36m(07) :[0m [34mfix-names TestPremiumizeMe:rclone-test-cenuzeb4zoko/015743so/extended_filenames/path2/Русский.txt[0m
2025/06/14 02:19:03 NOTICE: [36m(08) :[0m [34mfix-names /tmp/015743so/extended_filenames/path1/file_enconde_mañana_funcionará.txt[0m
2025/06/14 02:19:03 NOTICE: [36m(09) :[0m [34mfix-names TestPremiumizeMe:rclone-test-cenuzeb4zoko/015743so/extended_filenames/path2/file_enconde_mañana_funcionará.txt[0m
2025/06/14 02:19:08 NOTICE: [36m(10) :[0m [34mtest initial bisync[0m
2025/06/14 02:19:08 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 02:19:17 ERROR : error listing: directory not found
2025/06/14 02:19:18 ERROR : error listing: directory not found
2025/06/14 02:19:18 NOTICE: checking initFs Local file system at /tmp/015743so/initdir/test_filters-xoxoceq5
2025/06/14 02:19:18 NOTICE: checking Path1 Local file system at /tmp/015743so/filters/path1
panic: test timed out after 1h0m0s
running tests:
TestBisyncLocalRemote (22m23s)
TestBisyncLocalRemote/filters (45s)
goroutine 36494 [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, 22 minutes]:
testing.(*T).Run(0xc000c28700, {0x271aaab?, 0xc0000e3ad8?}, 0x2844518)
/usr/local/go/src/testing/testing.go:1859 +0x431
testing.runTests.func1(0xc000c28700)
/usr/local/go/src/testing/testing.go:2279 +0x37
testing.tRunner(0xc000c28700, 0xc0000e3c18)
/usr/local/go/src/testing/testing.go:1792 +0xf4
testing.runTests(0xc0009405b8, {0x3f39dc0, 0x3, 0x3}, {0x831580?, 0x3f9cf58?, 0x3f79180?})
/usr/local/go/src/testing/testing.go:2277 +0x4b4
testing.(*M).Run(0xc0007db860)
/usr/local/go/src/testing/testing.go:2142 +0x64a
github.com/rclone/rclone/fstest.TestMain(0xc0007db860)
/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 31 [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 32 [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 33 [select, 60 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0002e7080)
/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 182 [select, 60 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00088cb80)
/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 94
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 7806 [select, 47 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00088c2c0)
/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 7805
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 93 [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 7
/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68
goroutine 36462 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0xc001376100)
/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 36342
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:119 +0x436
goroutine 8 [select, 60 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000c04d40)
/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 7
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 23173 [chan receive, 2 minutes]:
testing.(*T).Run(0xc000c40a80, {0xc000a50eb5?, 0x2b49738?}, 0xc00117f200)
/usr/local/go/src/testing/testing.go:1859 +0x431
github.com/rclone/rclone/cmd/bisync_test.testBisync(0xc000c40a80, {0x0, 0x0}, {0xc000d01e60, 0x29})
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:351 +0x915
github.com/rclone/rclone/cmd/bisync_test.TestBisyncLocalRemote(0xc000c40a80)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:253 +0x165
testing.tRunner(0xc000c40a80, 0x2844518)
/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 92 [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 7
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7
goroutine 15166 [select, 34 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004bca40)
/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 15165
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 95 [select, 60 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00042b600)
/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 94
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 23221 [select, 22 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e9a5c0)
/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 23220
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 3162 [select, 55 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00088da40)
/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 3161
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 35761 [IO wait, 2 minutes]:
internal/poll.runtime_pollWait(0x784e3a38b290, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000869280?, 0xc0008e4000?, 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(0xc000869280, {0xc0008e4000, 0x1000, 0x1000})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000869280, {0xc0008e4000?, 0xab2?, 0xc000ae7840?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0000fc2a8, {0xc0008e4000?, 0xc0008e4549?, 0x5?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000b77b30, {0xc0008e4000?, 0x784e391ceff0?, 0x784e82883a78?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000bb22d0, {0xc0008e4000?, 0xab2?, 0x2?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000733b38, {0x2b5d940, 0xc000bb22d0})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000733888, {0x784e3815d628, 0xc000b77b30}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000733888, 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(0xc000733888, {0xc0008ee000, 0x1000, 0xc0003abca0?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
bufio.(*Reader).Read(0xc000c0dce0, {0xc000c16740, 0x9, 0x3eef330?})
/usr/local/go/src/bufio/bufio.go:245 +0x197
io.ReadAtLeast({0x2b5a840, 0xc000c0dce0}, {0xc000c16740, 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({0xc000c16740, 0x9, 0xc000017d40?}, {0x2b5a840?, 0xc000c0dce0?})
/usr/local/go/src/net/http/h2_bundle.go:1805 +0x65
net/http.(*http2Framer).ReadFrame(0xc000c16700)
/usr/local/go/src/net/http/h2_bundle.go:2072 +0x7d
net/http.(*http2clientConnReadLoop).run(0xc0003abfa8)
/usr/local/go/src/net/http/h2_bundle.go:9933 +0xda
net/http.(*http2ClientConn).readLoop(0xc0007c6000)
/usr/local/go/src/net/http/h2_bundle.go:9812 +0x79
created by net/http.(*http2Transport).newClientConn in goroutine 35760
/usr/local/go/src/net/http/h2_bundle.go:8334 +0xde5
goroutine 36493 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0xc0001f2800)
/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 36344
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:119 +0x436
goroutine 36445 [select]:
net/http.(*persistConn).writeLoop(0xc00085f680)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 36423
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 1730 [select, 57 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00080efc0)
/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 1729
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 21583 [select, 25 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e9ac40)
/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 21582
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 20221 [select, 26 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00107bdc0)
/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 20220
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 9485 [select, 45 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000502d40)
/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 8773
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 899 [select, 58 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0007ef6c0)
/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 898
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 5588 [select, 51 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e9a2c0)
/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 5587
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 10433 [select, 43 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000c05a40)
/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 10432
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36343 [chan receive]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc00117fb60)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x25
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc00117fb60, 0xc0007ef9c0, 0xa)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x5c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc00117fb60, 0xc0007ef9c0)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93
github.com/rclone/rclone/backend/premiumizeme.(*Fs).listAll(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0xc000bf84b0, 0x16}, 0x0, 0x1, 0xc000937900)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:416 +0x4b7
github.com/rclone/rclone/backend/premiumizeme.(*Fs).readMetaDataForPath(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0xc000ad41e0?, 0x25eba40?}, 0x0, 0x1)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:194 +0x145
github.com/rclone/rclone/backend/premiumizeme.(*Object).readMetaData(0xc000aa2a80, {0x2b83288?, 0xc001220b40?})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:868 +0x3f
github.com/rclone/rclone/backend/premiumizeme.(*Fs).newObjectWithInfo(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0xc000ad41e0, 0x9}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:329 +0x9c
github.com/rclone/rclone/backend/premiumizeme.(*Fs).Put(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0x2b5b040, 0xc000490200}, {0x784e3815d648, 0xc000d4a960}, {0xc000e96350, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:517 +0x79
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0xc0003e4b40, {0x2b83288, 0xc001220b40}, {0x2b6e680?, 0xc000b82000?}, {0xc000e96350, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:218 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc0003e4b40, {0x2b83288, 0xc001220b40})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:271 +0x6d8
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc0003e4b40, {0x2b83288, 0xc001220b40})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:311 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2b83288, 0xc001220b40}, {0x2b9aea0, 0xc00117fbc0}, {0x0, 0x0}, {0xc000ad41e0, 0x9}, {0x2b9a500, 0xc000d4a960})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:413 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc0002a4f08, {0x2b83288, 0xc001220b40}, 0xc001220a50, {0x2b9aea0, 0xc00117fbc0}, 0x19, 0xc000733c08?)
/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 35792
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 36444 [IO wait]:
internal/poll.runtime_pollWait(0x784e3a38ad18, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000aa2600?, 0xc0003f5500?, 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(0xc000aa2600, {0xc0003f5500, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000aa2600, {0xc0003f5500?, 0xa73?, 0xc000956fa0?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0000fc428, {0xc0003f5500?, 0xc000732c50?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0009e8c90, {0xc0003f5500?, 0x784e3a38fd58?, 0x784e82883108?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc0004972a8, {0xc0003f5500?, 0xa73?, 0xc0003ac9d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000732d38, {0x2b5d940, 0xc0004972a8})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000732a88, {0x784e3815d628, 0xc0009e8c90}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000732a88, 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(0xc000732a88, {0xc000a39000, 0x1000, 0xc00001ff20?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc00085f680, {0xc000a39000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc00066e4e0)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc00066e4e0, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc00085f680)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 36423
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 34878 [select, 4 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e9bec0)
/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 34877
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36354 [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 35792
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378
goroutine 36342 [chan receive]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc00117fb60)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x25
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc00117fb60, 0xc000e9b600, 0xa)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x5c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc00117fb60, 0xc000e9b600)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93
github.com/rclone/rclone/backend/premiumizeme.(*Fs).listAll(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0xc000bf84b0, 0x16}, 0x0, 0x1, 0xc0009a7900)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:416 +0x4b7
github.com/rclone/rclone/backend/premiumizeme.(*Fs).readMetaDataForPath(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0xc000ad4210?, 0x25eba40?}, 0x0, 0x1)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:194 +0x145
github.com/rclone/rclone/backend/premiumizeme.(*Object).readMetaData(0xc0007b8780, {0x2b83288?, 0xc001220b40?})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:868 +0x3f
github.com/rclone/rclone/backend/premiumizeme.(*Fs).newObjectWithInfo(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0xc000ad4210, 0x9}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:329 +0x9c
github.com/rclone/rclone/backend/premiumizeme.(*Fs).Put(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0x2b5b040, 0xc001376100}, {0x784e3815d648, 0xc000d4a9c0}, {0xc00119f5d0, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:517 +0x79
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0xc000b07680, {0x2b83288, 0xc001220b40}, {0x2b6e680?, 0xc0005a82a0?}, {0xc00119f5d0, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:218 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc000b07680, {0x2b83288, 0xc001220b40})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:271 +0x6d8
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc000b07680, {0x2b83288, 0xc001220b40})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:311 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2b83288, 0xc001220b40}, {0x2b9aea0, 0xc00117fbc0}, {0x0, 0x0}, {0xc000ad4210, 0x9}, {0x2b9a500, 0xc000d4a9c0})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:413 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc0002a4f08, {0x2b83288, 0xc001220b40}, 0xc001220a50, {0x2b9aea0, 0xc00117fbc0}, 0x0, 0xc000a59fa8?)
/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 35792
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 9658 [select, 45 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000b13a00)
/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 9657
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 11769 [select, 41 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00088dec0)
/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 10884
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 21494 [select, 25 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000879cc0)
/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 21075
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 2499 [select, 56 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004bc1c0)
/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 2498
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 12093 [select, 40 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000b13780)
/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 12092
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 18347 [chan receive (nil chan), 28 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 16759
/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378
goroutine 13680 [select, 36 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000879380)
/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 13679
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 35792 [sync.WaitGroup.Wait]:
sync.runtime_SemacquireWaitGroup(0x0?)
/usr/local/go/src/runtime/sema.go:110 +0x25
sync.(*WaitGroup).Wait(0xc001220a07?)
/usr/local/go/src/sync/waitgroup.go:118 +0x48
github.com/rclone/rclone/fs/sync.(*syncCopyMove).stopTransfers(0xc0002a4f08)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:543 +0x6f
github.com/rclone/rclone/fs/sync.(*syncCopyMove).run(0xc0002a4f08)
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:978 +0x325
github.com/rclone/rclone/fs/sync.runSyncCopyMove({0x2b83250, 0xc000629f20}, {0x2b9aea0, 0xc00117fbc0}, {0x2b9a490, 0xc0004954a0}, 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(0xc0007c6540, {0x2b831a8, 0x3f9c9c0}, 0x66b?, {0xc000a50eb5?, 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(0xc0007c61c0)
/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358 +0x234
testing.tRunner(0xc0007c61c0, 0xc00117f200)
/usr/local/go/src/testing/testing.go:1792 +0xf4
created by testing.(*T).Run in goroutine 23173
/usr/local/go/src/testing/testing.go:1851 +0x413
goroutine 7089 [select, 48 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00080ec80)
/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 7088
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 10885 [select, 43 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0005022c0)
/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 10884
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 12986 [select, 38 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000b12c00)
/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 12985
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36440 [IO wait]:
internal/poll.runtime_pollWait(0x784e3a38b060, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc0007b8200?, 0xc0003f4a80?, 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(0xc0007b8200, {0xc0003f4a80, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc0007b8200, {0xc0003f4a80?, 0xa73?, 0xc000956ec0?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0000fc358, {0xc0003f4a80?, 0xc0007328d0?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0009e8810, {0xc0003f4a80?, 0x784e8288c170?, 0x784e82883a78?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc0000102a0, {0xc0003f4a80?, 0xa73?, 0xc0007769d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0007329b8, {0x2b5d940, 0xc0000102a0})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000732708, {0x784e3815d628, 0xc0009e8810}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000732708, 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(0xc000732708, {0xc0003a7000, 0x1000, 0xc00001ff20?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc00063cc60, {0xc0003a7000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000ba8600)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000ba8600, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc00063cc60)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 36434
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 36345 [chan receive]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc00117fb60)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x25
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc00117fb60, 0xc0007efd00, 0xa)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x5c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc00117fb60, 0xc0007efd00)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93
github.com/rclone/rclone/backend/premiumizeme.(*Fs).listAll(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0xc000bf84b0, 0x16}, 0x0, 0x1, 0xc000891900)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:416 +0x4b7
github.com/rclone/rclone/backend/premiumizeme.(*Fs).readMetaDataForPath(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0xc000ad41b0?, 0x25eba40?}, 0x0, 0x1)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:194 +0x145
github.com/rclone/rclone/backend/premiumizeme.(*Object).readMetaData(0xc000aa2b00, {0x2b83288?, 0xc001220b40?})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:868 +0x3f
github.com/rclone/rclone/backend/premiumizeme.(*Fs).newObjectWithInfo(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0xc000ad41b0, 0xb}, 0x0)
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:329 +0x9c
github.com/rclone/rclone/backend/premiumizeme.(*Fs).Put(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0x2b5b040, 0xc000490400}, {0x784e3815d648, 0xc000d4a900}, {0xc000e96710, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:517 +0x79
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0xc0003e5290, {0x2b83288, 0xc001220b40}, {0x2b6e680?, 0xc000b820e0?}, {0xc000e96710, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:218 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc0003e5290, {0x2b83288, 0xc001220b40})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:271 +0x6d8
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc0003e5290, {0x2b83288, 0xc001220b40})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:311 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2b83288, 0xc001220b40}, {0x2b9aea0, 0xc00117fbc0}, {0x0, 0x0}, {0xc000ad41b0, 0xb}, {0x2b9a500, 0xc000d4a900})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:413 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc0002a4f08, {0x2b83288, 0xc001220b40}, 0xc001220a50, {0x2b9aea0, 0xc00117fbc0}, 0x4b, 0xc000e2f740?)
/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 35792
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 28590 [select, 14 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0007efb40)
/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 28589
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 9586 [select, 45 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00107a700)
/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 8773
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 21076 [select, 25 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0002e7cc0)
/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 21075
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 31726 [select, 10 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00107ae80)
/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 31725
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 18191 [select, 28 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000c056c0)
/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 16759
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 34427 [select, 4 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000c04dc0)
/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 33725
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36448 [IO wait]:
internal/poll.runtime_pollWait(0x784e3a38b3a8, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc0007b8600?, 0xc000a62000?, 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(0xc0007b8600, {0xc000a62000, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc0007b8600, {0xc000a62000?, 0xa73?, 0xc0009570a0?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0000fc4b0, {0xc000a62000?, 0xc000732fd0?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0009e9098, {0xc000a62000?, 0x784e380f9a18?, 0x784e828835c0?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc0009e9440, {0xc000a62000?, 0xa73?, 0xc0003ae9d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0007330b8, {0x2b5d940, 0xc0009e9440})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000732e08, {0x784e3815d628, 0xc0009e9098}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000732e08, 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(0xc000732e08, {0xc000a61000, 0x1000, 0xc00001ff20?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc0006ac6c0, {0xc000a61000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000b1ac60)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000b1ac60, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc0006ac6c0)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 36456
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 24019 [select, 20 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000afab80)
/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 24018
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 35793 [select, 2 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000afbb80)
/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 35792
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 9448 [select, 45 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000b13d40)
/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 8773
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 25651 [select, 18 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0011ff140)
/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 25650
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 23174 [select, 22 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000b46500)
/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 23173
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 9467 [select, 45 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00080e580)
/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 8773
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 29312 [select, 13 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000b47b80)
/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 29311
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 4028 [select, 54 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0002e7700)
/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 4027
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 15984 [select, 32 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e9a1c0)
/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 15983
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36471 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0xc000490200)
/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 36343
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:119 +0x436
goroutine 9622 [select, 45 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000879d40)
/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 8773
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 8774 [select, 46 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004bc600)
/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 8773
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 11824 [select, 40 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00107a240)
/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 10884
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 6307 [select, 49 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00080f140)
/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 6306
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 9556 [select, 45 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0007efb80)
/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 8773
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36470 [chan receive]:
github.com/rclone/rclone/backend/local.(*fadvise).worker(0xc0007ef880)
/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 36343
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:74 +0x11f
goroutine 36478 [chan receive]:
github.com/rclone/rclone/backend/local.(*fadvise).worker(0xc0007efbc0)
/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 36345
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:74 +0x11f
goroutine 33266 [select, 7 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000afa980)
/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 33185
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 23039 [select, 22 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00107a040)
/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 23220
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 32502 [select, 8 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000b13000)
/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 32501
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 17936 [select, 29 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0002e70c0)
/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 16759
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36441 [select]:
net/http.(*persistConn).writeLoop(0xc00063cc60)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 36434
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 34724 [select, 4 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0005038c0)
/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 33725
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 17907 [select, 29 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0004bc480)
/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 16759
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36468 [IO wait]:
internal/poll.runtime_pollWait(0x784e1bfebd30, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc0007b8500?, 0xc0008fb500?, 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(0xc0007b8500, {0xc0008fb500, 0xa80, 0xa80})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc0007b8500, {0xc0008fb500?, 0xa73?, 0xc0004a2140?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000528990, {0xc0008fb500?, 0xc0007901d0?, 0xd?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0000106c0, {0xc0008fb500?, 0x784e3a38fd58?, 0x784e82883108?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000497ed8, {0xc0008fb500?, 0xa73?, 0xc000fc09d0?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0007902b8, {0x2b5d940, 0xc000497ed8})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000790008, {0x784e3815d628, 0xc0000106c0}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000790008, 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(0xc000790008, {0xc000983000, 0x1000, 0xc00001ff20?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc00003c7e0, {0xc000983000?, 0x7f7bc5?, 0x2b5a660?})
/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc0001168a0)
/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc0001168a0, 0x1)
/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc00003c7e0)
/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 36430
/usr/local/go/src/net/http/transport.go:1944 +0x174f
goroutine 18148 [select, 29 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000c04540)
/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 16759
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 11768 [select, 41 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00088de00)
/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 10884
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 18730 [select, 27 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00107a2c0)
/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 18729
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 16760 [select, 31 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e9aa00)
/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 16759
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 30149 [select, 11 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000afa440)
/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 30148
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36449 [select]:
net/http.(*persistConn).writeLoop(0xc0006ac6c0)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 36456
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
goroutine 23219 [chan receive, 22 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 23173
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7
goroutine 14359 [select, 36 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e9b800)
/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 14358
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 22350 [select, 23 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00088c300)
/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 22349
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 11920 [select, 40 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00107ab00)
/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 10884
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 19321 [select, 27 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000c04e40)
/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 19320
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 26443 [select, 16 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0011ff640)
/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 26442
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 27147 [select, 15 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0007efd80)
/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 27146
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 30965 [select, 11 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000c05400)
/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 30964
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36344 [chan receive]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc00117fb60)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x25
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc00117fb60, 0xc000e9b740, 0xa)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x5c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc00117fb60, 0xc000e9b740)
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93
github.com/rclone/rclone/backend/premiumizeme.(*Object).Update(0xc0007b8800, {0x2b83288, 0xc001220b40}, {0x2b5b040, 0xc0001f2800}, {0x784e3815d648, 0xc000d4a360}, {0xc000994590, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:948 +0x549
github.com/rclone/rclone/backend/premiumizeme.(*Fs).PutUnchecked(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0x2b5b040, 0xc0001f2800}, {0x784e3815d648, 0xc000d4a360}, {0xc000994590, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:545 +0x14c
github.com/rclone/rclone/backend/premiumizeme.(*Fs).Put(0xc00117fbc0, {0x2b83288, 0xc001220b40}, {0x2b5b040, 0xc0001f2800}, {0x784e3815d648, 0xc000d4a360}, {0xc000994590, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/backend/premiumizeme/premiumizeme.go:523 +0x12c
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0xc000cb6000, {0x2b83288, 0xc001220b40}, {0x2b6e680?, 0xc000c16460?}, {0xc000994590, 0x1, 0x1})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:218 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0xc000cb6000, {0x2b83288, 0xc001220b40})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:271 +0x6d8
github.com/rclone/rclone/fs/operations.(*copy).copy(0xc000cb6000, {0x2b83288, 0xc001220b40})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:311 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2b83288, 0xc001220b40}, {0x2b9aea0, 0xc00117fbc0}, {0x0, 0x0}, {0xc000ad40f0, 0x9}, {0x2b9a500, 0xc000d4a360})
/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:413 +0x4db
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0xc0002a4f08, {0x2b83288, 0xc001220b40}, 0xc001220a50, {0x2b9aea0, 0xc00117fbc0}, 0x32, 0xc000e2ffa8?)
/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 35792
/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d
goroutine 19866 [select, 26 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc00080f500)
/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 19865
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 34604 [select, 5 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc0011ff880)
/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 33725
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36479 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0xc000490400)
/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 36345
/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:119 +0x436
goroutine 33726 [select, 6 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000e9a0c0)
/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 33725
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36461 [chan receive]:
github.com/rclone/rclone/backend/local.(*fadvise).worker(0xc000e9b5c0)
/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 36342
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:74 +0x11f
goroutine 36492 [chan receive]:
github.com/rclone/rclone/backend/local.(*fadvise).worker(0xc00088df00)
/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 36344
/home/rclone/go/src/github.com/rclone/rclone/backend/local/fadvise_unix.go:74 +0x11f
goroutine 35883 [IO wait]:
internal/poll.runtime_pollWait(0x784e3a38b178, 0x72)
/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000aa2f80?, 0xc000c33000?, 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(0xc000aa2f80, {0xc000c33000, 0x1000, 0x1000})
/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000aa2f80, {0xc000c33000?, 0xba7?, 0xc000956a60?})
/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0000fc520, {0xc000c33000?, 0xc000c33454?, 0x5?})
/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000c03b78, {0xc000c33000?, 0x784e1bfd16b8?, 0x784e82883108?})
/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc000b1c3d8, {0xc000c33000?, 0xba7?, 0x1?})
/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000733eb8, {0x2b5d940, 0xc000b1c3d8})
/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000733c08, {0x784e3815d628, 0xc000c03b78}, 0x4426d4?)
/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000733c08, 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(0xc000733c08, {0xc000c3f000, 0x1000, 0xc0003afca0?})
/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
bufio.(*Reader).Read(0xc000b70ba0, {0xc000c16900, 0x9, 0x3eef330?})
/usr/local/go/src/bufio/bufio.go:245 +0x197
io.ReadAtLeast({0x2b5a840, 0xc000b70ba0}, {0xc000c16900, 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({0xc000c16900, 0x9, 0xc00002bec0?}, {0x2b5a840?, 0xc000b70ba0?})
/usr/local/go/src/net/http/h2_bundle.go:1805 +0x65
net/http.(*http2Framer).ReadFrame(0xc000c168c0)
/usr/local/go/src/net/http/h2_bundle.go:2072 +0x7d
net/http.(*http2clientConnReadLoop).run(0xc0003affa8)
/usr/local/go/src/net/http/h2_bundle.go:9933 +0xda
net/http.(*http2ClientConn).readLoop(0xc0007c68c0)
/usr/local/go/src/net/http/h2_bundle.go:9812 +0x79
created by net/http.(*http2Transport).newClientConn in goroutine 35882
/usr/local/go/src/net/http/h2_bundle.go:8334 +0xde5
goroutine 24841 [select, 19 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0xc000b47380)
/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 24840
/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5
goroutine 36465 [sleep]:
time.Sleep(0x59682f00)
/usr/local/go/src/runtime/time.go:338 +0x165
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall.func1(0xc0007c68c0?)
/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 36344
/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:166 +0xef
goroutine 36469 [select]:
net/http.(*persistConn).writeLoop(0xc00003c7e0)
/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 36430
/usr/local/go/src/net/http/transport.go:1945 +0x17a5
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestPremiumizeMe: -verbose" - Finished ERROR in 1h0m1.617032372s (try 1/5): exit status 2: Failed []