"./bisync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^TestBisyncLocalRemote$/^(rclone_args|resolve|resync|resync_modes|rmdirs|volatile)$'" - Starting (try 2/5)
2024/04/26 02:00:50 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-tuqocor1cazikuw0yokozer1"
2024/04/26 02:00:50 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/04/26 02:00:50 DEBUG : proton drive root link ID 'rclone-test-tuqocor1cazikuw0yokozer1': Has cached credentials
2024/04/26 02:00:51 DEBUG : proton drive root link ID 'rclone-test-tuqocor1cazikuw0yokozer1': Used cached credential to initialize the ProtonDrive API
2024/04/26 02:00:51 DEBUG : Creating backend with remote "/tmp/rclone2568369783"
=== RUN   TestBisyncLocalRemote
2024/04/26 02:00:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-bajuwil3sawuxid1sezoxud6"
2024/04/26 02:00:51 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6': Has cached credentials
2024/04/26 02:00:52 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6': Used cached credential to initialize the ProtonDrive API
2024/04/26 02:00:53 remote: TestProtonDrive:rclone-test-bajuwil3sawuxid1sezoxud6
=== RUN   TestBisyncLocalRemote/rclone_args
2024/04/26 02:00:53 DEBUG : Creating backend with remote "/tmp/020053no"
2024/04/26 02:00:53 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/04/26 02:00:53 DEBUG : Creating backend with remote "/tmp/020053no/rclone_args/path1"
2024/04/26 02:00:53 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-bajuwil3sawuxid1sezoxud6/020053no"
2024/04/26 02:00:53 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no': Has cached credentials
2024/04/26 02:00:53 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no': Used cached credential to initialize the ProtonDrive API
2024/04/26 02:00:54 DEBUG : path2: Making directory
2024/04/26 02:00:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rclone_args/path2"
2024/04/26 02:00:56 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rclone_args/path2': Has cached credentials
2024/04/26 02:00:57 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rclone_args/path2': Used cached credential to initialize the ProtonDrive API
2024/04/26 02:01:27 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/initial"
2024/04/26 02:01:27 DEBUG : Creating backend with remote "/tmp/020053no/initdir/test_rclone_args-gexifiy1"
2024/04/26 02:01:27 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : subdir: Making directory with metadata
2024/04/26 02:01:27 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2024/04/26 02:01:27 DEBUG : Added delayed dir = "subdir", newDst=subdir
2024/04/26 02:01:27 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : Local file system at /tmp/020053no/initdir/test_rclone_args-gexifiy1: Waiting for checks to finish
2024/04/26 02:01:27 DEBUG : Local file system at /tmp/020053no/initdir/test_rclone_args-gexifiy1: Waiting for transfers to finish
2024/04/26 02:01:27 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:01:27 DEBUG : subdir/file20.txt.wijejad9.partial: renamed to: subdir/file20.txt
2024/04/26 02:01:27 INFO  : subdir/file20.txt: Copied (new)
2024/04/26 02:01:27 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:01:27 DEBUG : file2.txt.kabuyox3.partial: renamed to: file2.txt
2024/04/26 02:01:27 INFO  : file2.txt: Copied (new)
2024/04/26 02:01:27 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:01:27 DEBUG : subdir/file21.txt.hevoqoc3.partial: renamed to: subdir/file21.txt
2024/04/26 02:01:27 INFO  : subdir/file21.txt: Copied (new)
2024/04/26 02:01:27 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK
2024/04/26 02:01:27 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:01:27 DEBUG : file1.txt.garidir8.partial: renamed to: file1.txt
2024/04/26 02:01:27 INFO  : file1.txt: Copied (new)
2024/04/26 02:01:27 DEBUG : RCLONE_TEST.xuhelut9.partial: renamed to: RCLONE_TEST
2024/04/26 02:01:27 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:01:27 INFO  : subdir: Set directory modification time (using SetModTime)
2024/04/26 02:01:27 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/modfiles"
2024/04/26 02:01:27 DEBUG : Creating backend with remote "/tmp/020053no/datadir/test_rclone_args-givitos3"
2024/04/26 02:01:27 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file20.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file21.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : Local file system at /tmp/020053no/datadir/test_rclone_args-givitos3: Waiting for checks to finish
2024/04/26 02:01:27 DEBUG : Local file system at /tmp/020053no/datadir/test_rclone_args-givitos3: Waiting for transfers to finish
2024/04/26 02:01:27 DEBUG : file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:01:27 DEBUG : file21.txt.yiwuhup7.partial: renamed to: file21.txt
2024/04/26 02:01:27 INFO  : file21.txt: Copied (new)
2024/04/26 02:01:27 DEBUG : file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:01:27 DEBUG : file20.txt.suronom8.partial: renamed to: file20.txt
2024/04/26 02:01:27 INFO  : file20.txt: Copied (new)
2024/04/26 02:01:27 DEBUG : file2.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2024/04/26 02:01:27 DEBUG : file2.txt.revajih5.partial: renamed to: file2.txt
2024/04/26 02:01:27 INFO  : file2.txt: Copied (new)
2024/04/26 02:01:27 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2024/04/26 02:01:27 DEBUG : file1.txt.neneper0.partial: renamed to: file1.txt
2024/04/26 02:01:27 INFO  : file1.txt: Copied (new)
2024/04/26 02:01:27 ERROR : : error listing: directory not found
2024/04/26 02:01:27 ERROR : : error listing: directory not found
2024/04/26 02:01:27 checking initFs Local file system at /tmp/020053no/initdir/test_rclone_args-gexifiy1
2024/04/26 02:01:27 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : subdir: Making directory with metadata
2024/04/26 02:01:27 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2024/04/26 02:01:27 DEBUG : Added delayed dir = "subdir", newDst=subdir
2024/04/26 02:01:27 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:01:27 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file2.txt.luyibeh5.partial: renamed to: file2.txt
2024/04/26 02:01:27 INFO  : file2.txt: Copied (new)
2024/04/26 02:01:27 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:01:27 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK
2024/04/26 02:01:27 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:01:27 DEBUG : Local file system at /tmp/020053no/rclone_args/path1: Waiting for checks to finish
2024/04/26 02:01:27 DEBUG : RCLONE_TEST.nakosoj2.partial: renamed to: RCLONE_TEST
2024/04/26 02:01:27 DEBUG : subdir/file21.txt.sotaxuk7.partial: renamed to: subdir/file21.txt
2024/04/26 02:01:27 INFO  : subdir/file21.txt: Copied (new)
2024/04/26 02:01:27 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:01:27 DEBUG : file1.txt.gihadef1.partial: renamed to: file1.txt
2024/04/26 02:01:27 DEBUG : Local file system at /tmp/020053no/rclone_args/path1: Waiting for transfers to finish
2024/04/26 02:01:27 INFO  : file1.txt: Copied (new)
2024/04/26 02:01:27 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:01:27 DEBUG : subdir/file20.txt.haqanoq1.partial: renamed to: subdir/file20.txt
2024/04/26 02:01:27 INFO  : subdir/file20.txt: Copied (new)
2024/04/26 02:01:27 INFO  : subdir: Set directory modification time (using SetModTime)
2024/04/26 02:01:27 checking Path1 Local file system at /tmp/020053no/rclone_args/path1
2024/04/26 02:01:27 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:27 DEBUG : subdir: Making directory
2024/04/26 02:01:29 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:29 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination
2024/04/26 02:01:29 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rclone_args/path2': Waiting for checks to finish
2024/04/26 02:01:29 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rclone_args/path2': Waiting for transfers to finish
2024/04/26 02:01:30 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:01:30 INFO  : subdir/file20.txt: Copied (new)
2024/04/26 02:01:30 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:01:30 INFO  : file2.txt: Copied (new)
2024/04/26 02:01:31 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2024/04/26 02:01:31 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:01:31 DEBUG : file1.txt: sha1 = b7ee1cdd4f6d4b833b6990ea6977ce970aaa3366 OK
2024/04/26 02:01:31 INFO  : file1.txt: Copied (new)
2024/04/26 02:01:31 DEBUG : subdir/file21.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:01:31 INFO  : subdir/file21.txt: Copied (new)
2024/04/26 02:01:31 checking path2 proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rclone_args/path2'
2024/04/26 02:01:35 (01)  : test rclone-args
2024/04/26 02:01:35 (02)  : touch-glob 2001-01-02 /tmp/020053no/datadir/test_rclone_args-givitos3/ *
2024/04/26 02:01:35 (03)  : test initial bisync
2024/04/26 02:01:35 (04)  : bisync resync checksum
    bisync_test.go:958: skipping test as at least one remote does not support setting modtime
=== RUN   TestBisyncLocalRemote/resolve
2024/04/26 02:01:36 DEBUG : Creating backend with remote "/tmp/020053no/resolve/path1"
2024/04/26 02:01:36 DEBUG : path2: Making directory
2024/04/26 02:01:36 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resolve/path2"
2024/04/26 02:01:36 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resolve/path2': Has cached credentials
2024/04/26 02:01:37 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resolve/path2': Used cached credential to initialize the ProtonDrive API
2024/04/26 02:02:08 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resolve/initial"
2024/04/26 02:02:08 DEBUG : Creating backend with remote "/tmp/020053no/initdir/test_resolve-rubarak8"
2024/04/26 02:02:08 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:08 DEBUG : file2.txt.wehufuh4.partial: renamed to: file2.txt
2024/04/26 02:02:08 INFO  : file2.txt: Copied (new)
2024/04/26 02:02:08 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:08 DEBUG : Local file system at /tmp/020053no/initdir/test_resolve-rubarak8: Waiting for checks to finish
2024/04/26 02:02:08 DEBUG : Local file system at /tmp/020053no/initdir/test_resolve-rubarak8: Waiting for transfers to finish
2024/04/26 02:02:08 DEBUG : file1.txt.cacujem1.partial: renamed to: file1.txt
2024/04/26 02:02:08 INFO  : file1.txt: Copied (new)
2024/04/26 02:02:08 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:02:08 DEBUG : RCLONE_TEST.vowobit6.partial: renamed to: RCLONE_TEST
2024/04/26 02:02:08 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:02:08 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resolve/modfiles"
2024/04/26 02:02:08 DEBUG : Creating backend with remote "/tmp/020053no/datadir/test_resolve-dilebun2"
2024/04/26 02:02:08 DEBUG : file1L.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : file1R.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : Local file system at /tmp/020053no/datadir/test_resolve-dilebun2: Waiting for checks to finish
2024/04/26 02:02:08 DEBUG : Local file system at /tmp/020053no/datadir/test_resolve-dilebun2: Waiting for transfers to finish
2024/04/26 02:02:08 DEBUG : file1R.txt: md5 = 2b4975bb20f7be674e66d78570ba2fb1 OK
2024/04/26 02:02:08 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK
2024/04/26 02:02:08 DEBUG : file1R.txt.fefenij0.partial: renamed to: file1R.txt
2024/04/26 02:02:08 INFO  : file1R.txt: Copied (new)
2024/04/26 02:02:08 DEBUG : file1L.txt.wilamiy9.partial: renamed to: file1L.txt
2024/04/26 02:02:08 INFO  : file1L.txt: Copied (new)
2024/04/26 02:02:08 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK
2024/04/26 02:02:08 DEBUG : file2.txt.miyadej5.partial: renamed to: file2.txt
2024/04/26 02:02:08 INFO  : file2.txt: Copied (new)
2024/04/26 02:02:08 ERROR : : error listing: directory not found
2024/04/26 02:02:08 ERROR : : error listing: directory not found
2024/04/26 02:02:08 checking initFs Local file system at /tmp/020053no/initdir/test_resolve-rubarak8
2024/04/26 02:02:08 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : Local file system at /tmp/020053no/resolve/path1: Waiting for checks to finish
2024/04/26 02:02:08 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:08 DEBUG : file1.txt.puveboh0.partial: renamed to: file1.txt
2024/04/26 02:02:08 INFO  : file1.txt: Copied (new)
2024/04/26 02:02:08 DEBUG : Local file system at /tmp/020053no/resolve/path1: Waiting for transfers to finish
2024/04/26 02:02:08 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:08 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:02:08 DEBUG : RCLONE_TEST.vuyatod5.partial: renamed to: RCLONE_TEST
2024/04/26 02:02:08 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:02:08 DEBUG : file2.txt.zabezuf4.partial: renamed to: file2.txt
2024/04/26 02:02:08 INFO  : file2.txt: Copied (new)
2024/04/26 02:02:08 checking Path1 Local file system at /tmp/020053no/resolve/path1
2024/04/26 02:02:08 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:08 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resolve/path2': Waiting for checks to finish
2024/04/26 02:02:08 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resolve/path2': Waiting for transfers to finish
2024/04/26 02:02:11 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:02:11 INFO  : file2.txt: Copied (new)
2024/04/26 02:02:11 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:02:11 INFO  : file1.txt: Copied (new)
2024/04/26 02:02:11 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2024/04/26 02:02:11 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:02:11 checking path2 proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resolve/path2'
2024/04/26 02:02:13 (01)  : test resolve
2024/04/26 02:02:13 (02)  : test initial bisync
2024/04/26 02:02:13 (03)  : bisync resync
    bisync_test.go:958: skipping test as at least one remote does not support setting modtime
=== RUN   TestBisyncLocalRemote/resync
2024/04/26 02:02:15 DEBUG : Creating backend with remote "/tmp/020053no/resync/path1"
2024/04/26 02:02:15 DEBUG : path2: Making directory
2024/04/26 02:02:15 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync/path2"
2024/04/26 02:02:15 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync/path2': Has cached credentials
2024/04/26 02:02:16 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync/path2': Used cached credential to initialize the ProtonDrive API
2024/04/26 02:02:46 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial"
2024/04/26 02:02:46 DEBUG : Creating backend with remote "/tmp/020053no/initdir/test_resync-pejuraz7"
2024/04/26 02:02:46 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file3.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file4.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file5.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file6.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file7.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : Local file system at /tmp/020053no/initdir/test_resync-pejuraz7: Waiting for checks to finish
2024/04/26 02:02:46 DEBUG : file1.txt.ginijob3.partial: renamed to: file1.txt
2024/04/26 02:02:46 INFO  : file1.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : Local file system at /tmp/020053no/initdir/test_resync-pejuraz7: Waiting for transfers to finish
2024/04/26 02:02:46 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file2.txt.nuhekav2.partial: renamed to: file2.txt
2024/04/26 02:02:46 INFO  : file2.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file4.txt.hiwocec6.partial: renamed to: file4.txt
2024/04/26 02:02:46 INFO  : file4.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : file3.txt.tejugay9.partial: renamed to: file3.txt
2024/04/26 02:02:46 INFO  : file3.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:02:46 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file5.txt.volidok2.partial: renamed to: file5.txt
2024/04/26 02:02:46 INFO  : file5.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : RCLONE_TEST.busubur5.partial: renamed to: RCLONE_TEST
2024/04/26 02:02:46 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:02:46 DEBUG : file6.txt.cavulil8.partial: renamed to: file6.txt
2024/04/26 02:02:46 INFO  : file6.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file7.txt.cenaler0.partial: renamed to: file7.txt
2024/04/26 02:02:46 INFO  : file7.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles"
2024/04/26 02:02:46 DEBUG : Creating backend with remote "/tmp/020053no/datadir/test_resync-papeqit4"
2024/04/26 02:02:46 DEBUG : fileA.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : fileB.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : Local file system at /tmp/020053no/datadir/test_resync-papeqit4: Waiting for checks to finish
2024/04/26 02:02:46 DEBUG : Local file system at /tmp/020053no/datadir/test_resync-papeqit4: Waiting for transfers to finish
2024/04/26 02:02:46 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2024/04/26 02:02:46 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2024/04/26 02:02:46 DEBUG : fileA.txt.dikikir4.partial: renamed to: fileA.txt
2024/04/26 02:02:46 DEBUG : fileB.txt.batomus9.partial: renamed to: fileB.txt
2024/04/26 02:02:46 INFO  : fileA.txt: Copied (new)
2024/04/26 02:02:46 INFO  : fileB.txt: Copied (new)
2024/04/26 02:02:46 ERROR : : error listing: directory not found
2024/04/26 02:02:46 ERROR : : error listing: directory not found
2024/04/26 02:02:46 checking initFs Local file system at /tmp/020053no/initdir/test_resync-pejuraz7
2024/04/26 02:02:46 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file3.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file4.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file5.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file6.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file7.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : Local file system at /tmp/020053no/resync/path1: Waiting for checks to finish
2024/04/26 02:02:46 DEBUG : Local file system at /tmp/020053no/resync/path1: Waiting for transfers to finish
2024/04/26 02:02:46 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file1.txt.banodos1.partial: renamed to: file1.txt
2024/04/26 02:02:46 INFO  : file1.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file2.txt.taxucib2.partial: renamed to: file2.txt
2024/04/26 02:02:46 INFO  : file2.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : file3.txt.joquzob8.partial: renamed to: file3.txt
2024/04/26 02:02:46 INFO  : file3.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:02:46 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : RCLONE_TEST.tuqidan1.partial: renamed to: RCLONE_TEST
2024/04/26 02:02:46 DEBUG : file5.txt.wagucaw8.partial: renamed to: file5.txt
2024/04/26 02:02:46 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:02:46 INFO  : file5.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : file4.txt.hulojom0.partial: renamed to: file4.txt
2024/04/26 02:02:46 INFO  : file4.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file7.txt.golasuq3.partial: renamed to: file7.txt
2024/04/26 02:02:46 INFO  : file7.txt: Copied (new)
2024/04/26 02:02:46 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:02:46 DEBUG : file6.txt.teselil1.partial: renamed to: file6.txt
2024/04/26 02:02:46 INFO  : file6.txt: Copied (new)
2024/04/26 02:02:46 checking Path1 Local file system at /tmp/020053no/resync/path1
2024/04/26 02:02:46 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file3.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file4.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file5.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file6.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : file7.txt: Need to transfer - File not found at Destination
2024/04/26 02:02:46 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync/path2': Waiting for checks to finish
2024/04/26 02:02:46 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync/path2': Waiting for transfers to finish
2024/04/26 02:02:49 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:02:49 INFO  : file1.txt: Copied (new)
2024/04/26 02:02:49 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:02:49 INFO  : file3.txt: Copied (new)
2024/04/26 02:02:49 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:02:49 INFO  : file2.txt: Copied (new)
2024/04/26 02:02:49 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2024/04/26 02:02:49 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:02:50 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:02:50 INFO  : file4.txt: Copied (new)
2024/04/26 02:02:50 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:02:50 INFO  : file5.txt: Copied (new)
2024/04/26 02:02:50 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:02:50 INFO  : file6.txt: Copied (new)
2024/04/26 02:02:50 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:02:50 INFO  : file7.txt: Copied (new)
2024/04/26 02:02:50 checking path2 proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync/path2'
2024/04/26 02:02:56 (01)  : test resync
2024/04/26 02:02:56 (02)  : test 1. resync with empty path1, resulting in copying all content from path2.
2024/04/26 02:02:56 (03)  : purge-children /tmp/020053no/resync/path1/
2024/04/26 02:02:56 (04)  : bisync resync
    bisync_test.go:958: skipping test as at least one remote does not support setting modtime
=== RUN   TestBisyncLocalRemote/resync_modes
2024/04/26 02:02:57 DEBUG : Creating backend with remote "/tmp/020053no/resync_modes/path1"
2024/04/26 02:02:57 DEBUG : path2: Making directory
2024/04/26 02:02:57 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync_modes/path2"
2024/04/26 02:02:57 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync_modes/path2': Has cached credentials
2024/04/26 02:02:58 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync_modes/path2': Used cached credential to initialize the ProtonDrive API
2024/04/26 02:03:28 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/initial"
2024/04/26 02:03:28 DEBUG : Creating backend with remote "/tmp/020053no/initdir/test_resync_modes-nuwogan4"
2024/04/26 02:03:28 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:03:28 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:03:28 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:03:28 DEBUG : Local file system at /tmp/020053no/initdir/test_resync_modes-nuwogan4: Waiting for checks to finish
2024/04/26 02:03:28 DEBUG : Local file system at /tmp/020053no/initdir/test_resync_modes-nuwogan4: Waiting for transfers to finish
2024/04/26 02:03:28 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:03:28 DEBUG : file1.txt.fobosak8.partial: renamed to: file1.txt
2024/04/26 02:03:28 INFO  : file1.txt: Copied (new)
2024/04/26 02:03:28 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:03:28 DEBUG : file2.txt.fuxepey4.partial: renamed to: file2.txt
2024/04/26 02:03:28 INFO  : file2.txt: Copied (new)
2024/04/26 02:03:28 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:03:28 DEBUG : RCLONE_TEST.copacal8.partial: renamed to: RCLONE_TEST
2024/04/26 02:03:28 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:03:28 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/modfiles"
2024/04/26 02:03:28 DEBUG : Creating backend with remote "/tmp/020053no/datadir/test_resync_modes-tehumaw0"
2024/04/26 02:03:28 DEBUG : file1L.txt: Need to transfer - File not found at Destination
2024/04/26 02:03:28 DEBUG : file1R.txt: Need to transfer - File not found at Destination
2024/04/26 02:03:28 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:03:28 DEBUG : Local file system at /tmp/020053no/datadir/test_resync_modes-tehumaw0: Waiting for checks to finish
2024/04/26 02:03:28 DEBUG : Local file system at /tmp/020053no/datadir/test_resync_modes-tehumaw0: Waiting for transfers to finish
2024/04/26 02:03:28 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK
2024/04/26 02:03:28 DEBUG : file1L.txt.rocunan3.partial: renamed to: file1L.txt
2024/04/26 02:03:28 INFO  : file1L.txt: Copied (new)
2024/04/26 02:03:28 DEBUG : file1R.txt: md5 = 705bb3c0ef02925739e834ca98c099c3 OK
2024/04/26 02:03:28 DEBUG : file1R.txt.bazoxeq0.partial: renamed to: file1R.txt
2024/04/26 02:03:28 INFO  : file1R.txt: Copied (new)
2024/04/26 02:03:28 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK
2024/04/26 02:03:28 DEBUG : file2.txt.hoqicah8.partial: renamed to: file2.txt
2024/04/26 02:03:28 INFO  : file2.txt: Copied (new)
2024/04/26 02:03:28 ERROR : : error listing: directory not found
2024/04/26 02:03:28 ERROR : : error listing: directory not found
2024/04/26 02:03:28 checking initFs Local file system at /tmp/020053no/initdir/test_resync_modes-nuwogan4
2024/04/26 02:03:28 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:03:28 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:03:28 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:03:28 DEBUG : Local file system at /tmp/020053no/resync_modes/path1: Waiting for checks to finish
2024/04/26 02:03:28 DEBUG : Local file system at /tmp/020053no/resync_modes/path1: Waiting for transfers to finish
2024/04/26 02:03:28 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:03:28 DEBUG : file2.txt.citifux2.partial: renamed to: file2.txt
2024/04/26 02:03:28 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:03:28 DEBUG : file1.txt.levuheq8.partial: renamed to: file1.txt
2024/04/26 02:03:28 INFO  : file1.txt: Copied (new)
2024/04/26 02:03:28 INFO  : file2.txt: Copied (new)
2024/04/26 02:03:28 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:03:28 DEBUG : RCLONE_TEST.seyapuk1.partial: renamed to: RCLONE_TEST
2024/04/26 02:03:28 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:03:28 checking Path1 Local file system at /tmp/020053no/resync_modes/path1
2024/04/26 02:03:29 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:03:29 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:03:29 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:03:29 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync_modes/path2': Waiting for checks to finish
2024/04/26 02:03:29 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync_modes/path2': Waiting for transfers to finish
2024/04/26 02:03:31 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:03:31 INFO  : file1.txt: Copied (new)
2024/04/26 02:03:32 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:03:32 INFO  : file2.txt: Copied (new)
2024/04/26 02:03:32 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2024/04/26 02:03:32 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:03:32 checking path2 proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync_modes/path2'
2024/04/26 02:03:34 (01)  : test resync-mode
2024/04/26 02:03:34 (02)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2024/04/26 02:03:34 (03)  : touch-glob 2001-01-02 /tmp/020053no/datadir/test_resync_modes-tehumaw0/ file1R.txt
2024/04/26 02:03:34 (04)  : copy-as /tmp/020053no/datadir/test_resync_modes-tehumaw0/file1R.txt TestProtonDrive:rclone-test-bajuwil3sawuxid1sezoxud6/020053no/resync_modes/path2/ file1.txt
2024/04/26 02:03:52.812650 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1
2024/04/26 02:03:52.812686 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422)
2024/04/26 02:03:54 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2024/04/26 02:03:54 (05)  : touch-glob 2001-03-04 /tmp/020053no/datadir/test_resync_modes-tehumaw0/ file1L.txt
2024/04/26 02:03:54 (06)  : copy-as /tmp/020053no/datadir/test_resync_modes-tehumaw0/file1L.txt /tmp/020053no/resync_modes/path1/ file1.txt
2024/04/26 02:03:54 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2024/04/26 02:03:54 (07)  : test bisync run with --resync-mode=newer
2024/04/26 02:03:54 (08)  : bisync resync resync-mode=newer
    bisync_test.go:958: skipping test as at least one remote does not support setting modtime
=== RUN   TestBisyncLocalRemote/rmdirs
2024/04/26 02:03:56 DEBUG : Creating backend with remote "/tmp/020053no/rmdirs/path1"
2024/04/26 02:03:56 DEBUG : path2: Making directory
2024/04/26 02:03:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rmdirs/path2"
2024/04/26 02:03:56 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rmdirs/path2': Has cached credentials
2024/04/26 02:03:56 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rmdirs/path2': Used cached credential to initialize the ProtonDrive API
2024/04/26 02:04:26 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/initial"
2024/04/26 02:04:26 DEBUG : Config file has changed externally - reloading
2024/04/26 02:04:26 DEBUG : Creating backend with remote "/tmp/020053no/initdir/test_rmdirs-dofekel1"
2024/04/26 02:04:26 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:04:26 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:26 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:26 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:26 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:26 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:26 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:26 DEBUG : subdir: Making directory with metadata
2024/04/26 02:04:26 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2024/04/26 02:04:26 DEBUG : Added delayed dir = "subdir", newDst=subdir
2024/04/26 02:04:26 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:26 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:26 DEBUG : Local file system at /tmp/020053no/initdir/test_rmdirs-dofekel1: Waiting for checks to finish
2024/04/26 02:04:26 DEBUG : Local file system at /tmp/020053no/initdir/test_rmdirs-dofekel1: Waiting for transfers to finish
2024/04/26 02:04:26 DEBUG : file1.copy2.txt.vobukis3.partial: renamed to: file1.copy2.txt
2024/04/26 02:04:26 INFO  : file1.copy2.txt: Copied (new)
2024/04/26 02:04:26 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:26 DEBUG : file1.copy1.txt.futuzow9.partial: renamed to: file1.copy1.txt
2024/04/26 02:04:26 INFO  : file1.copy1.txt: Copied (new)
2024/04/26 02:04:26 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:26 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:26 DEBUG : file1.copy4.txt.kunayuk5.partial: renamed to: file1.copy4.txt
2024/04/26 02:04:26 INFO  : file1.copy4.txt: Copied (new)
2024/04/26 02:04:26 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:04:26 DEBUG : file1.copy5.txt.mowoday7.partial: renamed to: file1.copy5.txt
2024/04/26 02:04:26 DEBUG : RCLONE_TEST.tuhinef5.partial: renamed to: RCLONE_TEST
2024/04/26 02:04:26 INFO  : file1.copy5.txt: Copied (new)
2024/04/26 02:04:26 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:04:26 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:26 DEBUG : file1.copy3.txt.pahuliq4.partial: renamed to: file1.copy3.txt
2024/04/26 02:04:26 INFO  : file1.copy3.txt: Copied (new)
2024/04/26 02:04:26 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:26 DEBUG : file1.txt.peruxor8.partial: renamed to: file1.txt
2024/04/26 02:04:26 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:26 INFO  : file1.txt: Copied (new)
2024/04/26 02:04:26 DEBUG : subdir/file20.txt.zuqodus7.partial: renamed to: subdir/file20.txt
2024/04/26 02:04:26 INFO  : subdir/file20.txt: Copied (new)
2024/04/26 02:04:26 INFO  : subdir: Set directory modification time (using SetModTime)
2024/04/26 02:04:26 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rmdirs/modfiles"
2024/04/26 02:04:26 DEBUG : Creating backend with remote "/tmp/020053no/datadir/test_rmdirs-yesuwib9"
2024/04/26 02:04:26 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:26 DEBUG : Local file system at /tmp/020053no/datadir/test_rmdirs-yesuwib9: Waiting for checks to finish
2024/04/26 02:04:26 DEBUG : Local file system at /tmp/020053no/datadir/test_rmdirs-yesuwib9: Waiting for transfers to finish
2024/04/26 02:04:26 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2024/04/26 02:04:26 DEBUG : file1.txt.dejocud5.partial: renamed to: file1.txt
2024/04/26 02:04:26 INFO  : file1.txt: Copied (new)
2024/04/26 02:04:26 ERROR : : error listing: directory not found
2024/04/26 02:04:27 ERROR : : error listing: directory not found
2024/04/26 02:04:27 checking initFs Local file system at /tmp/020053no/initdir/test_rmdirs-dofekel1
2024/04/26 02:04:27 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : subdir: Making directory with metadata
2024/04/26 02:04:27 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:27 DEBUG : file1.copy2.txt.pozosut7.partial: renamed to: file1.copy2.txt
2024/04/26 02:04:27 INFO  : file1.copy2.txt: Copied (new)
2024/04/26 02:04:27 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2024/04/26 02:04:27 DEBUG : Added delayed dir = "subdir", newDst=subdir
2024/04/26 02:04:27 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:27 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:04:27 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:27 DEBUG : RCLONE_TEST.buhufik0.partial: renamed to: RCLONE_TEST
2024/04/26 02:04:27 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:04:27 DEBUG : file1.copy3.txt.macaqaq8.partial: renamed to: file1.copy3.txt
2024/04/26 02:04:27 INFO  : file1.copy3.txt: Copied (new)
2024/04/26 02:04:27 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:27 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:27 DEBUG : Local file system at /tmp/020053no/rmdirs/path1: Waiting for checks to finish
2024/04/26 02:04:27 DEBUG : Local file system at /tmp/020053no/rmdirs/path1: Waiting for transfers to finish
2024/04/26 02:04:27 DEBUG : file1.copy4.txt.racehog5.partial: renamed to: file1.copy4.txt
2024/04/26 02:04:27 DEBUG : file1.copy1.txt.basiqog1.partial: renamed to: file1.copy1.txt
2024/04/26 02:04:27 INFO  : file1.copy1.txt: Copied (new)
2024/04/26 02:04:27 INFO  : file1.copy4.txt: Copied (new)
2024/04/26 02:04:27 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:27 DEBUG : file1.txt.jaribaj7.partial: renamed to: file1.txt
2024/04/26 02:04:27 INFO  : file1.txt: Copied (new)
2024/04/26 02:04:27 DEBUG : file1.copy5.txt.loriyij3.partial: renamed to: file1.copy5.txt
2024/04/26 02:04:27 INFO  : file1.copy5.txt: Copied (new)
2024/04/26 02:04:27 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:04:27 DEBUG : subdir/file20.txt.niwehij5.partial: renamed to: subdir/file20.txt
2024/04/26 02:04:27 INFO  : subdir/file20.txt: Copied (new)
2024/04/26 02:04:27 INFO  : subdir: Set directory modification time (using SetModTime)
2024/04/26 02:04:27 checking Path1 Local file system at /tmp/020053no/rmdirs/path1
2024/04/26 02:04:27 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:27 DEBUG : subdir: Making directory
2024/04/26 02:04:29 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2024/04/26 02:04:29 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rmdirs/path2': Waiting for checks to finish
2024/04/26 02:04:29 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rmdirs/path2': Waiting for transfers to finish
2024/04/26 02:04:30 DEBUG : file1.copy2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:04:30 INFO  : file1.copy2.txt: Copied (new)
2024/04/26 02:04:30 DEBUG : file1.copy1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:04:30 INFO  : file1.copy1.txt: Copied (new)
2024/04/26 02:04:30 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2024/04/26 02:04:30 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:04:30 DEBUG : file1.copy3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:04:30 INFO  : file1.copy3.txt: Copied (new)
2024/04/26 02:04:31 DEBUG : file1.copy4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:04:31 INFO  : file1.copy4.txt: Copied (new)
2024/04/26 02:04:31 DEBUG : file1.copy5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:04:31 INFO  : file1.copy5.txt: Copied (new)
2024/04/26 02:04:31 DEBUG : subdir/file20.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:04:31 INFO  : subdir/file20.txt: Copied (new)
2024/04/26 02:04:31 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:04:31 INFO  : file1.txt: Copied (new)
2024/04/26 02:04:31 checking path2 proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/rmdirs/path2'
2024/04/26 02:04:37 (01)  : test rmdirs
2024/04/26 02:04:37 (02)  : test initial bisync
2024/04/26 02:04:37 (03)  : bisync resync
    bisync_test.go:958: skipping test as at least one remote does not support setting modtime
=== RUN   TestBisyncLocalRemote/volatile
2024/04/26 02:04:38 DEBUG : Creating backend with remote "/tmp/020053no/volatile/path1"
2024/04/26 02:04:38 DEBUG : path2: Making directory
2024/04/26 02:04:38 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-bajuwil3sawuxid1sezoxud6/020053no/volatile/path2"
2024/04/26 02:04:38 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/volatile/path2': Has cached credentials
2024/04/26 02:04:39 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/volatile/path2': Used cached credential to initialize the ProtonDrive API
2024/04/26 02:05:09 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/initial"
2024/04/26 02:05:09 DEBUG : Config file has changed externally - reloading
2024/04/26 02:05:09 DEBUG : Creating backend with remote "/tmp/020053no/initdir/test_volatile-xabukim4"
2024/04/26 02:05:09 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file3.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file4.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file5.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file6.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file7.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file1.txt.sanudan8.partial: renamed to: file1.txt
2024/04/26 02:05:09 INFO  : file1.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file8.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file2.txt.rijobaw0.partial: renamed to: file2.txt
2024/04/26 02:05:09 INFO  : file2.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : Local file system at /tmp/020053no/initdir/test_volatile-xabukim4: Waiting for checks to finish
2024/04/26 02:05:09 DEBUG : file3.txt.fayowih0.partial: renamed to: file3.txt
2024/04/26 02:05:09 INFO  : file3.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : Local file system at /tmp/020053no/initdir/test_volatile-xabukim4: Waiting for transfers to finish
2024/04/26 02:05:09 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:05:09 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : RCLONE_TEST.naruxid3.partial: renamed to: RCLONE_TEST
2024/04/26 02:05:09 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:05:09 DEBUG : file5.txt.yifadom0.partial: renamed to: file5.txt
2024/04/26 02:05:09 INFO  : file5.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file6.txt.xumamaj3.partial: renamed to: file6.txt
2024/04/26 02:05:09 INFO  : file6.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file4.txt.rifasov3.partial: renamed to: file4.txt
2024/04/26 02:05:09 INFO  : file4.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file8.txt.sisedar7.partial: renamed to: file8.txt
2024/04/26 02:05:09 INFO  : file8.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file7.txt.rulehoz1.partial: renamed to: file7.txt
2024/04/26 02:05:09 INFO  : file7.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_volatile/modfiles"
2024/04/26 02:05:09 DEBUG : Creating backend with remote "/tmp/020053no/datadir/test_volatile-vonokih5"
2024/04/26 02:05:09 DEBUG : dummy.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file10.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file11.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file5L.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file5R.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file6.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file7.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : dummy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : dummy.txt.labanud5.partial: renamed to: dummy.txt
2024/04/26 02:05:09 INFO  : dummy.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : Local file system at /tmp/020053no/datadir/test_volatile-vonokih5: Waiting for checks to finish
2024/04/26 02:05:09 DEBUG : Local file system at /tmp/020053no/datadir/test_volatile-vonokih5: Waiting for transfers to finish
2024/04/26 02:05:09 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2024/04/26 02:05:09 DEBUG : file1.txt.litukag3.partial: renamed to: file1.txt
2024/04/26 02:05:09 INFO  : file1.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2024/04/26 02:05:09 DEBUG : file10.txt.hobipuy5.partial: renamed to: file10.txt
2024/04/26 02:05:09 INFO  : file10.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK
2024/04/26 02:05:09 DEBUG : file2.txt.fivikej2.partial: renamed to: file2.txt
2024/04/26 02:05:09 INFO  : file2.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2024/04/26 02:05:09 DEBUG : file11.txt.sabafir0.partial: renamed to: file11.txt
2024/04/26 02:05:09 INFO  : file11.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK
2024/04/26 02:05:09 DEBUG : file5L.txt.lopajib6.partial: renamed to: file5L.txt
2024/04/26 02:05:09 INFO  : file5L.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK
2024/04/26 02:05:09 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2024/04/26 02:05:09 DEBUG : file5R.txt.docifax4.partial: renamed to: file5R.txt
2024/04/26 02:05:09 INFO  : file5R.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file6.txt.zaxiqat3.partial: renamed to: file6.txt
2024/04/26 02:05:09 INFO  : file6.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2024/04/26 02:05:09 DEBUG : file7.txt.qixazeb5.partial: renamed to: file7.txt
2024/04/26 02:05:09 INFO  : file7.txt: Copied (new)
2024/04/26 02:05:09 ERROR : : error listing: directory not found
2024/04/26 02:05:09 ERROR : : error listing: directory not found
2024/04/26 02:05:09 checking initFs Local file system at /tmp/020053no/initdir/test_volatile-xabukim4
2024/04/26 02:05:09 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file3.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file4.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file5.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file6.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file7.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file8.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file1.txt.livanuj4.partial: renamed to: file1.txt
2024/04/26 02:05:09 INFO  : file1.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : Local file system at /tmp/020053no/volatile/path1: Waiting for checks to finish
2024/04/26 02:05:09 DEBUG : Local file system at /tmp/020053no/volatile/path1: Waiting for transfers to finish
2024/04/26 02:05:09 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file3.txt.peguqiy9.partial: renamed to: file3.txt
2024/04/26 02:05:09 INFO  : file3.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file2.txt.qomikiw7.partial: renamed to: file2.txt
2024/04/26 02:05:09 INFO  : file2.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file4.txt.viruyac2.partial: renamed to: file4.txt
2024/04/26 02:05:09 INFO  : file4.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2024/04/26 02:05:09 DEBUG : RCLONE_TEST.tuliduw1.partial: renamed to: RCLONE_TEST
2024/04/26 02:05:09 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:05:09 DEBUG : file5.txt.duvopol7.partial: renamed to: file5.txt
2024/04/26 02:05:09 INFO  : file5.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file6.txt.yemibex1.partial: renamed to: file6.txt
2024/04/26 02:05:09 INFO  : file6.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file7.txt.pujujob0.partial: renamed to: file7.txt
2024/04/26 02:05:09 INFO  : file7.txt: Copied (new)
2024/04/26 02:05:09 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2024/04/26 02:05:09 DEBUG : file8.txt.jepalew9.partial: renamed to: file8.txt
2024/04/26 02:05:09 INFO  : file8.txt: Copied (new)
2024/04/26 02:05:09 checking Path1 Local file system at /tmp/020053no/volatile/path1
2024/04/26 02:05:09 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file1.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file2.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file3.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file4.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file5.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file6.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file7.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : file8.txt: Need to transfer - File not found at Destination
2024/04/26 02:05:09 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/volatile/path2': Waiting for checks to finish
2024/04/26 02:05:09 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/volatile/path2': Waiting for transfers to finish
2024/04/26 02:05:12 DEBUG : file1.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:05:12 INFO  : file1.txt: Copied (new)
2024/04/26 02:05:12 DEBUG : file3.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:05:12 INFO  : file3.txt: Copied (new)
2024/04/26 02:05:12 DEBUG : file2.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:05:12 INFO  : file2.txt: Copied (new)
2024/04/26 02:05:13 DEBUG : RCLONE_TEST: sha1 = c799ac3b0eacf2b6fc3e741a7bea196aa129aab2 OK
2024/04/26 02:05:13 INFO  : RCLONE_TEST: Copied (new)
2024/04/26 02:05:13 DEBUG : file4.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:05:13 INFO  : file4.txt: Copied (new)
2024/04/26 02:05:13 DEBUG : file5.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:05:13 INFO  : file5.txt: Copied (new)
2024/04/26 02:05:13 DEBUG : file6.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:05:13 INFO  : file6.txt: Copied (new)
2024/04/26 02:05:14 DEBUG : file7.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:05:14 INFO  : file7.txt: Copied (new)
2024/04/26 02:05:14 DEBUG : file8.txt: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK
2024/04/26 02:05:14 INFO  : file8.txt: Copied (new)
2024/04/26 02:05:14 checking path2 proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6/020053no/volatile/path2'
2024/04/26 02:05:20 (01)  : test volatile
2024/04/26 02:05:20 (02)  : test initial bisync
2024/04/26 02:05:20 (03)  : bisync resync
    bisync_test.go:921: skipping 'volatile' test on non-local as it requires uploading 100 files
2024/04/26 02:05:20 DEBUG : proton drive root link ID 'rclone-test-bajuwil3sawuxid1sezoxud6': Purge remote
--- PASS: TestBisyncLocalRemote (283.60s)
    --- SKIP: TestBisyncLocalRemote/rclone_args (43.72s)
    --- SKIP: TestBisyncLocalRemote/resolve (38.56s)
    --- SKIP: TestBisyncLocalRemote/resync (42.47s)
    --- SKIP: TestBisyncLocalRemote/resync_modes (58.22s)
    --- SKIP: TestBisyncLocalRemote/rmdirs (42.68s)
    --- SKIP: TestBisyncLocalRemote/volatile (41.96s)
PASS
2024/04/26 02:05:35 DEBUG : proton drive root link ID 'rclone-test-tuqocor1cazikuw0yokozer1': Purge remote
2024/04/26 02:05:35 purge failed: directory not found
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^TestBisyncLocalRemote$/^(rclone_args|resolve|resync|resync_modes|rmdirs|volatile)$'" - Finished OK in 4m45.305947194s (try 2/5)