"./bisync.test -test.v -test.timeout 1h0m0s -remote TestInternxt: -list-retries 5 -verbose -test.run '^TestBisyncLocalRemote$/^(all_changed|max_delete_path2_force|normalization)$|^TestBisyncRemoteLocal$/^rclone_args$|^TestBisyncRemoteRemote$/^(changes|concurrent|equal|filters|max_delete_path1|max_delete_path2_force|resync)$'" - Starting (try 4/5) 2026/02/21 04:56:52 DEBUG : Creating backend with remote "TestInternxt:rclone-test-wobunir1duxe" 2026/02/21 04:56:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/02/21 04:56:52 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:56:52 DEBUG : Creating backend with remote "/tmp/rclone502383412" === RUN TestBisyncRemoteLocal 2026/02/21 04:56:52 DEBUG : Creating backend with remote "TestInternxt:rclone-test-rijacez1topa" 2026/02/21 04:56:53 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:56:53 NOTICE: remote: TestInternxt:rclone-test-rijacez1topa === RUN TestBisyncRemoteLocal/rclone_args 2026/02/21 04:56:53 DEBUG : Creating backend with remote "TestInternxt:rclone-test-rijacez1topa/045653fi" 2026/02/21 04:56:53 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:56:53 INFO : path1: Making directory 2026/02/21 04:56:54 DEBUG : Creating backend with remote "TestInternxt:rclone-test-rijacez1topa/045653fi/rclone_args/path1" 2026/02/21 04:56:54 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:56:55 DEBUG : Creating backend with remote "/tmp/045653fi" 2026/02/21 04:56:55 DEBUG : Creating backend with remote "/tmp/045653fi/rclone_args/path2" 2026/02/21 04:56:55 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/initial" 2026/02/21 04:56:55 DEBUG : Creating backend with remote "/tmp/045653fi/initdir/test_rclone_args-nehequg1" 2026/02/21 04:56:55 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:56:55 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:55 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:55 DEBUG : subdir: Making directory with metadata 2026/02/21 04:56:55 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2026/02/21 04:56:55 DEBUG : Added delayed dir = "subdir", newDst=subdir 2026/02/21 04:56:55 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:55 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:55 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 04:56:55 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:56:55 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 04:56:55 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:56:55 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2026/02/21 04:56:55 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:56:55 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2026/02/21 04:56:55 INFO : subdir/file20.txt: Copied (new) 2026/02/21 04:56:55 DEBUG : Local file system at /tmp/045653fi/initdir/test_rclone_args-nehequg1: Waiting for checks to finish 2026/02/21 04:56:55 DEBUG : Local file system at /tmp/045653fi/initdir/test_rclone_args-nehequg1: Waiting for transfers to finish 2026/02/21 04:56:55 DEBUG : file1.txt.3d039419.partial: size = 19 OK 2026/02/21 04:56:55 DEBUG : subdir/file21.txt.8fb30fba.partial: size = 0 OK 2026/02/21 04:56:55 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 04:56:55 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:56:55 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK 2026/02/21 04:56:55 DEBUG : file1.txt.3d039419.partial: renamed to: file1.txt 2026/02/21 04:56:55 INFO : file1.txt: Copied (new) 2026/02/21 04:56:55 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:56:55 DEBUG : subdir/file21.txt.8fb30fba.partial: renamed to: subdir/file21.txt 2026/02/21 04:56:55 INFO : subdir/file21.txt: Copied (new) 2026/02/21 04:56:55 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 04:56:55 INFO : file2.txt: Copied (new) 2026/02/21 04:56:55 INFO : subdir: Set directory modification time (using SetModTime) 2026/02/21 04:56:55 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_rclone_args/modfiles" 2026/02/21 04:56:55 DEBUG : Creating backend with remote "/tmp/045653fi/datadir/test_rclone_args-joxohiw1" 2026/02/21 04:56:55 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:55 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:55 DEBUG : file20.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:55 DEBUG : file21.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:55 DEBUG : file20.txt.fd848222.partial: size = 0 OK 2026/02/21 04:56:55 DEBUG : Local file system at /tmp/045653fi/datadir/test_rclone_args-joxohiw1: Waiting for checks to finish 2026/02/21 04:56:55 DEBUG : file21.txt.68f456b7.partial: size = 0 OK 2026/02/21 04:56:55 DEBUG : file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:56:55 DEBUG : file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:56:55 DEBUG : file20.txt.fd848222.partial: renamed to: file20.txt 2026/02/21 04:56:55 INFO : file20.txt: Copied (new) 2026/02/21 04:56:55 DEBUG : file21.txt.68f456b7.partial: renamed to: file21.txt 2026/02/21 04:56:55 INFO : file21.txt: Copied (new) 2026/02/21 04:56:55 DEBUG : Local file system at /tmp/045653fi/datadir/test_rclone_args-joxohiw1: Waiting for transfers to finish 2026/02/21 04:56:55 DEBUG : file1.txt.8c06417f.partial: size = 19 OK 2026/02/21 04:56:55 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:56:55 DEBUG : file1.txt.8c06417f.partial: renamed to: file1.txt 2026/02/21 04:56:55 INFO : file1.txt: Copied (new) 2026/02/21 04:56:55 DEBUG : file2.txt.d6677e1f.partial: size = 19 OK 2026/02/21 04:56:55 DEBUG : file2.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:56:55 DEBUG : file2.txt.d6677e1f.partial: renamed to: file2.txt 2026/02/21 04:56:55 INFO : file2.txt: Copied (new) 2026/02/21 04:56:55 DEBUG : Waiting for deletions to finish 2026/02/21 04:56:55 ERROR : error listing: directory not found 2026/02/21 04:56:55 ERROR : Internxt root 'rclone-test-rijacez1topa/045653fi/rclone_args/path1': Failed to list "": directory not found 2026/02/21 04:56:55 DEBUG : removing 1 level 0 directories 2026/02/21 04:56:55 INFO : Internxt root 'rclone-test-rijacez1topa/045653fi/rclone_args/path1': Removing directory 2026/02/21 04:56:55 ERROR : Failed to rmdir: directory not found 2026/02/21 04:56:55 DEBUG : Waiting for deletions to finish 2026/02/21 04:56:55 ERROR : error listing: directory not found 2026/02/21 04:56:55 ERROR : Local file system at /tmp/045653fi/rclone_args/path2: Failed to list "": directory not found 2026/02/21 04:56:55 DEBUG : removing 1 level 0 directories 2026/02/21 04:56:55 INFO : Local file system at /tmp/045653fi/rclone_args/path2: Removing directory 2026/02/21 04:56:55 ERROR : Failed to rmdir: stat /tmp/045653fi/rclone_args/path2: no such file or directory 2026/02/21 04:56:56 ERROR : error listing: directory not found 2026/02/21 04:56:56 ERROR : error listing: directory not found 2026/02/21 04:56:56 NOTICE: checking initFs Local file system at /tmp/045653fi/initdir/test_rclone_args-nehequg1 2026/02/21 04:56:56 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:56:56 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:56 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:56 INFO : subdir: Making directory 2026/02/21 04:56:56 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:56 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2026/02/21 04:56:56 DEBUG : Internxt root 'rclone-test-rijacez1topa/045653fi/rclone_args/path1': Waiting for checks to finish 2026/02/21 04:56:56 DEBUG : Internxt root 'rclone-test-rijacez1topa/045653fi/rclone_args/path1': Waiting for transfers to finish 2026/02/21 04:56:57 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 04:56:57 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:56:58 DEBUG : file1.txt: size = 19 OK 2026/02/21 04:56:58 INFO : file1.txt: Copied (new) 2026/02/21 04:56:59 DEBUG : file2.txt: size = 0 OK 2026/02/21 04:56:59 INFO : file2.txt: Copied (new) 2026/02/21 04:56:59 DEBUG : subdir/file21.txt: size = 0 OK 2026/02/21 04:56:59 INFO : subdir/file21.txt: Copied (new) 2026/02/21 04:56:59 DEBUG : subdir/file20.txt: size = 0 OK 2026/02/21 04:56:59 INFO : subdir/file20.txt: Copied (new) 2026/02/21 04:56:59 NOTICE: checking Path1 Internxt root 'rclone-test-rijacez1topa/045653fi/rclone_args/path1' 2026/02/21 04:57:00 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:57:00 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:00 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:00 DEBUG : subdir: Making directory with metadata 2026/02/21 04:57:00 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2026/02/21 04:57:00 DEBUG : Added delayed dir = "subdir", newDst=subdir 2026/02/21 04:57:00 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:00 DEBUG : subdir/file21.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:00 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 04:57:00 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:00 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 04:57:00 DEBUG : Local file system at /tmp/045653fi/rclone_args/path2: Waiting for checks to finish 2026/02/21 04:57:00 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 04:57:00 INFO : file2.txt: Copied (new) 2026/02/21 04:57:00 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:57:00 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2026/02/21 04:57:00 DEBUG : Local file system at /tmp/045653fi/rclone_args/path2: Waiting for transfers to finish 2026/02/21 04:57:00 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 04:57:00 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:57:00 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:00 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2026/02/21 04:57:00 INFO : subdir/file20.txt: Copied (new) 2026/02/21 04:57:00 DEBUG : file1.txt.3d039419.partial: size = 19 OK 2026/02/21 04:57:00 DEBUG : subdir/file21.txt.8fb30fba.partial: size = 0 OK 2026/02/21 04:57:00 DEBUG : subdir/file21.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:00 DEBUG : file1.txt: md5 = 06bf632289064f6deae02a9f6f07856c OK 2026/02/21 04:57:00 DEBUG : subdir/file21.txt.8fb30fba.partial: renamed to: subdir/file21.txt 2026/02/21 04:57:00 INFO : subdir/file21.txt: Copied (new) 2026/02/21 04:57:00 DEBUG : file1.txt.3d039419.partial: renamed to: file1.txt 2026/02/21 04:57:00 INFO : file1.txt: Copied (new) 2026/02/21 04:57:00 INFO : subdir: Set directory modification time (using SetModTime) 2026/02/21 04:57:00 NOTICE: checking path2 Local file system at /tmp/045653fi/rclone_args/path2 2026/02/21 04:57:00 NOTICE: (01) : test rclone-args 2026/02/21 04:57:00 NOTICE: (02) : touch-glob 2001-01-02 /tmp/045653fi/datadir/test_rclone_args-joxohiw1/ * 2026/02/21 04:57:00 DEBUG : Creating backend with remote "/tmp/045653fi/datadir/test_rclone_args-joxohiw1/" 2026/02/21 04:57:00 DEBUG : fs cache: renaming cache item "/tmp/045653fi/datadir/test_rclone_args-joxohiw1/" to be canonical "/tmp/045653fi/datadir/test_rclone_args-joxohiw1" 2026/02/21 04:57:00 DEBUG : file21.txt: Set modification time 2001-01-02 2026/02/21 04:57:00 DEBUG : file1.txt: Set modification time 2001-01-02 2026/02/21 04:57:00 DEBUG : file2.txt: Set modification time 2001-01-02 2026/02/21 04:57:00 DEBUG : file20.txt: Set modification time 2001-01-02 2026/02/21 04:57:00 NOTICE: (03) : test initial bisync 2026/02/21 04:57:00 NOTICE: (04) : bisync resync checksum bisync_test.go:1015: skipping test as at least one remote does not support setting modtime 2026/02/21 04:57:01 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge object "045653fi/rclone_args/path1/RCLONE_TEST" 2026/02/21 04:57:02 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge object "045653fi/rclone_args/path1/file1.txt" 2026/02/21 04:57:02 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge object "045653fi/rclone_args/path1/file2.txt" 2026/02/21 04:57:02 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge object "045653fi/rclone_args/path1/subdir/file20.txt" 2026/02/21 04:57:02 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge object "045653fi/rclone_args/path1/subdir/file21.txt" 2026/02/21 04:57:03 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge dir "045653fi/rclone_args/path1/subdir" 2026/02/21 04:57:03 NOTICE: purge failed to rmdir "045653fi/rclone_args/path1/subdir": directory not empty 2026/02/21 04:57:03 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge dir "045653fi/rclone_args/path1" 2026/02/21 04:57:03 NOTICE: purge failed to rmdir "045653fi/rclone_args/path1": directory not empty 2026/02/21 04:57:03 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge dir "045653fi/rclone_args" 2026/02/21 04:57:03 NOTICE: purge failed to rmdir "045653fi/rclone_args": directory not empty 2026/02/21 04:57:03 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge dir "045653fi/path1" 2026/02/21 04:57:03 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge dir "045653fi" 2026/02/21 04:57:03 NOTICE: purge failed to rmdir "045653fi": directory not empty 2026/02/21 04:57:03 DEBUG : Internxt root 'rclone-test-rijacez1topa': Purge dir "" 2026/02/21 04:57:04 NOTICE: purge failed to rmdir "": directory not empty --- PASS: TestBisyncRemoteLocal (11.10s) --- SKIP: TestBisyncRemoteLocal/rclone_args (6.80s) === RUN TestBisyncLocalRemote 2026/02/21 04:57:04 DEBUG : Creating backend with remote "TestInternxt:rclone-test-jatexof5zonu" 2026/02/21 04:57:04 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:57:04 NOTICE: remote: TestInternxt:rclone-test-jatexof5zonu === RUN TestBisyncLocalRemote/all_changed 2026/02/21 04:57:04 DEBUG : Creating backend with remote "/tmp/045704yo" 2026/02/21 04:57:04 DEBUG : Creating backend with remote "/tmp/045704yo/all_changed/path1" 2026/02/21 04:57:04 DEBUG : Creating backend with remote "TestInternxt:rclone-test-jatexof5zonu/045704yo" 2026/02/21 04:57:04 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:57:05 INFO : path2: Making directory 2026/02/21 04:57:05 DEBUG : Creating backend with remote "TestInternxt:rclone-test-jatexof5zonu/045704yo/all_changed/path2" 2026/02/21 04:57:06 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:57:06 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_all_changed/initial" 2026/02/21 04:57:06 DEBUG : Creating backend with remote "/tmp/045704yo/initdir/test_all_changed-tucunor1" 2026/02/21 04:57:06 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:57:06 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:06 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:06 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:06 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:06 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:06 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:06 DEBUG : subdir: Making directory with metadata 2026/02/21 04:57:06 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2026/02/21 04:57:06 DEBUG : Added delayed dir = "subdir", newDst=subdir 2026/02/21 04:57:06 DEBUG : file1.copy1.txt.21b8fa2b.partial: size = 0 OK 2026/02/21 04:57:06 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:06 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:06 DEBUG : file1.copy2.txt.455881d5.partial: size = 0 OK 2026/02/21 04:57:06 DEBUG : Local file system at /tmp/045704yo/initdir/test_all_changed-tucunor1: Waiting for checks to finish 2026/02/21 04:57:06 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt 2026/02/21 04:57:06 INFO : file1.copy1.txt: Copied (new) 2026/02/21 04:57:06 DEBUG : Local file system at /tmp/045704yo/initdir/test_all_changed-tucunor1: Waiting for transfers to finish 2026/02/21 04:57:06 DEBUG : file1.copy3.txt.d0285540.partial: size = 0 OK 2026/02/21 04:57:06 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:06 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt 2026/02/21 04:57:06 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:06 INFO : file1.copy2.txt: Copied (new) 2026/02/21 04:57:06 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 04:57:06 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:57:06 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt 2026/02/21 04:57:06 INFO : file1.copy3.txt: Copied (new) 2026/02/21 04:57:06 DEBUG : file1.copy4.txt.8c987629.partial: size = 0 OK 2026/02/21 04:57:06 DEBUG : file1.copy5.txt.19e8a2bc.partial: size = 0 OK 2026/02/21 04:57:06 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:06 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 04:57:06 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:57:06 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:06 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt 2026/02/21 04:57:06 INFO : file1.copy5.txt: Copied (new) 2026/02/21 04:57:06 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2026/02/21 04:57:06 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:06 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 04:57:06 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:06 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt 2026/02/21 04:57:06 INFO : file1.copy4.txt: Copied (new) 2026/02/21 04:57:06 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2026/02/21 04:57:06 INFO : subdir/file20.txt: Copied (new) 2026/02/21 04:57:06 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 04:57:06 INFO : file1.txt: Copied (new) 2026/02/21 04:57:06 INFO : subdir: Set directory modification time (using SetModTime) 2026/02/21 04:57:06 DEBUG : Waiting for deletions to finish 2026/02/21 04:57:06 ERROR : error listing: directory not found 2026/02/21 04:57:06 ERROR : Local file system at /tmp/045704yo/all_changed/path1: Failed to list "": directory not found 2026/02/21 04:57:06 DEBUG : removing 1 level 0 directories 2026/02/21 04:57:06 INFO : Local file system at /tmp/045704yo/all_changed/path1: Removing directory 2026/02/21 04:57:06 ERROR : Failed to rmdir: stat /tmp/045704yo/all_changed/path1: no such file or directory 2026/02/21 04:57:06 DEBUG : Waiting for deletions to finish 2026/02/21 04:57:07 ERROR : error listing: directory not found 2026/02/21 04:57:07 ERROR : Internxt root 'rclone-test-jatexof5zonu/045704yo/all_changed/path2': Failed to list "": directory not found 2026/02/21 04:57:07 DEBUG : removing 1 level 0 directories 2026/02/21 04:57:07 INFO : Internxt root 'rclone-test-jatexof5zonu/045704yo/all_changed/path2': Removing directory 2026/02/21 04:57:07 ERROR : Failed to rmdir: directory not found 2026/02/21 04:57:07 ERROR : error listing: directory not found 2026/02/21 04:57:07 ERROR : error listing: directory not found 2026/02/21 04:57:07 NOTICE: checking initFs Local file system at /tmp/045704yo/initdir/test_all_changed-tucunor1 2026/02/21 04:57:07 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.copy1.txt.21b8fa2b.partial: size = 0 OK 2026/02/21 04:57:07 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:07 DEBUG : file1.copy3.txt.d0285540.partial: size = 0 OK 2026/02/21 04:57:07 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:07 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt 2026/02/21 04:57:07 INFO : file1.copy3.txt: Copied (new) 2026/02/21 04:57:07 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : subdir: Making directory with metadata 2026/02/21 04:57:07 DEBUG : file1.copy2.txt.455881d5.partial: size = 0 OK 2026/02/21 04:57:07 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:07 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt 2026/02/21 04:57:07 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2026/02/21 04:57:07 INFO : file1.copy2.txt: Copied (new) 2026/02/21 04:57:07 DEBUG : Added delayed dir = "subdir", newDst=subdir 2026/02/21 04:57:07 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt 2026/02/21 04:57:07 INFO : file1.copy1.txt: Copied (new) 2026/02/21 04:57:07 DEBUG : file1.copy4.txt.8c987629.partial: size = 0 OK 2026/02/21 04:57:07 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:07 DEBUG : file1.copy5.txt.19e8a2bc.partial: size = 0 OK 2026/02/21 04:57:07 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt 2026/02/21 04:57:07 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 04:57:07 INFO : file1.copy4.txt: Copied (new) 2026/02/21 04:57:07 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:07 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:07 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 04:57:07 INFO : file1.txt: Copied (new) 2026/02/21 04:57:07 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt 2026/02/21 04:57:07 DEBUG : Local file system at /tmp/045704yo/all_changed/path1: Waiting for checks to finish 2026/02/21 04:57:07 INFO : file1.copy5.txt: Copied (new) 2026/02/21 04:57:07 DEBUG : Local file system at /tmp/045704yo/all_changed/path1: Waiting for transfers to finish 2026/02/21 04:57:07 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 04:57:07 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:57:07 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 04:57:07 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2026/02/21 04:57:07 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:57:07 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:07 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2026/02/21 04:57:07 INFO : subdir/file20.txt: Copied (new) 2026/02/21 04:57:07 INFO : subdir: Set directory modification time (using SetModTime) 2026/02/21 04:57:07 NOTICE: checking Path1 Local file system at /tmp/045704yo/all_changed/path1 2026/02/21 04:57:07 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:07 INFO : subdir: Making directory 2026/02/21 04:57:08 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:08 DEBUG : Internxt root 'rclone-test-jatexof5zonu/045704yo/all_changed/path2': Waiting for checks to finish 2026/02/21 04:57:08 DEBUG : Internxt root 'rclone-test-jatexof5zonu/045704yo/all_changed/path2': Waiting for transfers to finish 2026/02/21 04:57:08 DEBUG : file1.copy1.txt: size = 0 OK 2026/02/21 04:57:08 INFO : file1.copy1.txt: Copied (new) 2026/02/21 04:57:08 DEBUG : file1.copy3.txt: size = 0 OK 2026/02/21 04:57:08 INFO : file1.copy3.txt: Copied (new) 2026/02/21 04:57:08 DEBUG : file1.copy2.txt: size = 0 OK 2026/02/21 04:57:08 INFO : file1.copy2.txt: Copied (new) 2026/02/21 04:57:09 DEBUG : file1.txt: size = 0 OK 2026/02/21 04:57:09 INFO : file1.txt: Copied (new) 2026/02/21 04:57:09 DEBUG : file1.copy4.txt: size = 0 OK 2026/02/21 04:57:09 INFO : file1.copy4.txt: Copied (new) 2026/02/21 04:57:09 DEBUG : file1.copy5.txt: size = 0 OK 2026/02/21 04:57:09 INFO : file1.copy5.txt: Copied (new) 2026/02/21 04:57:09 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 04:57:09 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:57:10 DEBUG : subdir/file20.txt: size = 0 OK 2026/02/21 04:57:10 INFO : subdir/file20.txt: Copied (new) 2026/02/21 04:57:10 NOTICE: checking path2 Internxt root 'rclone-test-jatexof5zonu/045704yo/all_changed/path2' 2026/02/21 04:57:10 NOTICE: (01) : test all-changed 2026/02/21 04:57:10 NOTICE: (02) : test initial bisync 2026/02/21 04:57:10 NOTICE: (03) : bisync resync bisync_test.go:1015: skipping test as at least one remote does not support setting modtime === RUN TestBisyncLocalRemote/max_delete_path2_force 2026/02/21 04:57:10 DEBUG : Creating backend with remote "/tmp/045704yo/max_delete_path2_force/path1" 2026/02/21 04:57:10 INFO : path2: Making directory 2026/02/21 04:57:10 DEBUG : Creating backend with remote "TestInternxt:rclone-test-jatexof5zonu/045704yo/max_delete_path2_force/path2" 2026/02/21 04:57:10 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:57:11 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path2_force/initial" 2026/02/21 04:57:11 DEBUG : Creating backend with remote "/tmp/045704yo/initdir/test_max_delete_path2_force-fehelep7" 2026/02/21 04:57:11 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:11 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:11 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:11 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:11 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:11 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:11 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:11 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:11 DEBUG : file9.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:11 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 04:57:11 DEBUG : Local file system at /tmp/045704yo/initdir/test_max_delete_path2_force-fehelep7: Waiting for checks to finish 2026/02/21 04:57:11 DEBUG : Local file system at /tmp/045704yo/initdir/test_max_delete_path2_force-fehelep7: Waiting for transfers to finish 2026/02/21 04:57:11 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 04:57:11 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2026/02/21 04:57:11 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:11 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:11 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2026/02/21 04:57:11 INFO : file4.txt: Copied (new) 2026/02/21 04:57:11 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 04:57:11 INFO : file2.txt: Copied (new) 2026/02/21 04:57:11 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2026/02/21 04:57:11 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:11 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:11 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2026/02/21 04:57:11 INFO : file5.txt: Copied (new) 2026/02/21 04:57:11 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 04:57:11 INFO : file1.txt: Copied (new) 2026/02/21 04:57:11 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2026/02/21 04:57:11 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:11 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2026/02/21 04:57:11 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2026/02/21 04:57:11 INFO : file7.txt: Copied (new) 2026/02/21 04:57:11 DEBUG : file8.txt.b300b322.partial: size = 0 OK 2026/02/21 04:57:11 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:11 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2026/02/21 04:57:11 INFO : file6.txt: Copied (new) 2026/02/21 04:57:11 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2026/02/21 04:57:11 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:11 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2026/02/21 04:57:11 INFO : file3.txt: Copied (new) 2026/02/21 04:57:11 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:11 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt 2026/02/21 04:57:11 INFO : file8.txt: Copied (new) 2026/02/21 04:57:11 DEBUG : file9.txt.84a50ab9.partial: size = 109 OK 2026/02/21 04:57:11 DEBUG : file9.txt: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:57:11 DEBUG : file9.txt.84a50ab9.partial: renamed to: file9.txt 2026/02/21 04:57:11 INFO : file9.txt: Copied (new) 2026/02/21 04:57:11 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path2_force/modfiles" 2026/02/21 04:57:11 DEBUG : Creating backend with remote "/tmp/045704yo/datadir/test_max_delete_path2_force-nuwayop4" 2026/02/21 04:57:11 DEBUG : hold.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:11 DEBUG : Local file system at /tmp/045704yo/datadir/test_max_delete_path2_force-nuwayop4: Waiting for checks to finish 2026/02/21 04:57:11 DEBUG : Local file system at /tmp/045704yo/datadir/test_max_delete_path2_force-nuwayop4: Waiting for transfers to finish 2026/02/21 04:57:11 DEBUG : hold.txt.83686dab.partial: size = 59 OK 2026/02/21 04:57:11 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2026/02/21 04:57:11 DEBUG : hold.txt.83686dab.partial: renamed to: hold.txt 2026/02/21 04:57:11 INFO : hold.txt: Copied (new) 2026/02/21 04:57:11 DEBUG : Waiting for deletions to finish 2026/02/21 04:57:11 ERROR : error listing: directory not found 2026/02/21 04:57:11 ERROR : Local file system at /tmp/045704yo/max_delete_path2_force/path1: Failed to list "": directory not found 2026/02/21 04:57:11 DEBUG : removing 1 level 0 directories 2026/02/21 04:57:11 INFO : Local file system at /tmp/045704yo/max_delete_path2_force/path1: Removing directory 2026/02/21 04:57:11 ERROR : Failed to rmdir: stat /tmp/045704yo/max_delete_path2_force/path1: no such file or directory 2026/02/21 04:57:11 DEBUG : Waiting for deletions to finish 2026/02/21 04:57:11 ERROR : error listing: directory not found 2026/02/21 04:57:11 ERROR : Internxt root 'rclone-test-jatexof5zonu/045704yo/max_delete_path2_force/path2': Failed to list "": directory not found 2026/02/21 04:57:11 DEBUG : removing 1 level 0 directories 2026/02/21 04:57:11 INFO : Internxt root 'rclone-test-jatexof5zonu/045704yo/max_delete_path2_force/path2': Removing directory 2026/02/21 04:57:11 ERROR : Failed to rmdir: directory not found 2026/02/21 04:57:11 ERROR : error listing: directory not found 2026/02/21 04:57:12 ERROR : error listing: directory not found 2026/02/21 04:57:12 NOTICE: checking initFs Local file system at /tmp/045704yo/initdir/test_max_delete_path2_force-fehelep7 2026/02/21 04:57:12 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file9.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 04:57:12 DEBUG : Local file system at /tmp/045704yo/max_delete_path2_force/path1: Waiting for checks to finish 2026/02/21 04:57:12 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:12 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 04:57:12 DEBUG : Local file system at /tmp/045704yo/max_delete_path2_force/path1: Waiting for transfers to finish 2026/02/21 04:57:12 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2026/02/21 04:57:12 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 04:57:12 INFO : file1.txt: Copied (new) 2026/02/21 04:57:12 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:12 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:12 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2026/02/21 04:57:12 INFO : file4.txt: Copied (new) 2026/02/21 04:57:12 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2026/02/21 04:57:12 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:12 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 04:57:12 INFO : file2.txt: Copied (new) 2026/02/21 04:57:12 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2026/02/21 04:57:12 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2026/02/21 04:57:12 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2026/02/21 04:57:12 INFO : file3.txt: Copied (new) 2026/02/21 04:57:12 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:12 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:12 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2026/02/21 04:57:12 INFO : file6.txt: Copied (new) 2026/02/21 04:57:12 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2026/02/21 04:57:12 INFO : file5.txt: Copied (new) 2026/02/21 04:57:12 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2026/02/21 04:57:12 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:12 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2026/02/21 04:57:12 INFO : file7.txt: Copied (new) 2026/02/21 04:57:12 DEBUG : file8.txt.b300b322.partial: size = 0 OK 2026/02/21 04:57:12 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:12 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt 2026/02/21 04:57:12 INFO : file8.txt: Copied (new) 2026/02/21 04:57:12 DEBUG : file9.txt.84a50ab9.partial: size = 109 OK 2026/02/21 04:57:12 DEBUG : file9.txt: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:57:12 DEBUG : file9.txt.84a50ab9.partial: renamed to: file9.txt 2026/02/21 04:57:12 INFO : file9.txt: Copied (new) 2026/02/21 04:57:12 NOTICE: checking Path1 Local file system at /tmp/045704yo/max_delete_path2_force/path1 2026/02/21 04:57:12 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : file9.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:12 DEBUG : Internxt root 'rclone-test-jatexof5zonu/045704yo/max_delete_path2_force/path2': Waiting for checks to finish 2026/02/21 04:57:12 DEBUG : Internxt root 'rclone-test-jatexof5zonu/045704yo/max_delete_path2_force/path2': Waiting for transfers to finish 2026/02/21 04:57:12 DEBUG : file2.txt: size = 0 OK 2026/02/21 04:57:12 INFO : file2.txt: Copied (new) 2026/02/21 04:57:13 DEBUG : file1.txt: size = 0 OK 2026/02/21 04:57:13 INFO : file1.txt: Copied (new) 2026/02/21 04:57:13 DEBUG : file4.txt: size = 0 OK 2026/02/21 04:57:13 INFO : file4.txt: Copied (new) 2026/02/21 04:57:13 DEBUG : file5.txt: size = 0 OK 2026/02/21 04:57:13 INFO : file5.txt: Copied (new) 2026/02/21 04:57:13 DEBUG : file3.txt: size = 0 OK 2026/02/21 04:57:13 INFO : file3.txt: Copied (new) 2026/02/21 04:57:13 DEBUG : file6.txt: size = 0 OK 2026/02/21 04:57:13 INFO : file6.txt: Copied (new) 2026/02/21 04:57:14 DEBUG : file8.txt: size = 0 OK 2026/02/21 04:57:14 INFO : file8.txt: Copied (new) 2026/02/21 04:57:14 DEBUG : file7.txt: size = 0 OK 2026/02/21 04:57:14 INFO : file7.txt: Copied (new) 2026/02/21 04:57:14 DEBUG : file9.txt: size = 109 OK 2026/02/21 04:57:14 INFO : file9.txt: Copied (new) 2026/02/21 04:57:14 NOTICE: checking path2 Internxt root 'rclone-test-jatexof5zonu/045704yo/max_delete_path2_force/path2' 2026/02/21 04:57:14 NOTICE: (01) : test max-delete-path2-force 2026/02/21 04:57:14 NOTICE: (02) : test initial bisync 2026/02/21 04:57:14 NOTICE: (03) : bisync resync bisync_test.go:1015: skipping test as at least one remote does not support setting modtime === RUN TestBisyncLocalRemote/normalization 2026/02/21 04:57:14 DEBUG : Creating backend with remote "/tmp/045704yo/normalization/path1" 2026/02/21 04:57:14 INFO : path2: Making directory 2026/02/21 04:57:14 DEBUG : Creating backend with remote "TestInternxt:rclone-test-jatexof5zonu/045704yo/normalization/path2" 2026/02/21 04:57:15 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:57:15 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_normalization/initial" 2026/02/21 04:57:15 DEBUG : Creating backend with remote "/tmp/045704yo/initdir/test_normalization-quwuhun2" 2026/02/21 04:57:15 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:57:15 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2026/02/21 04:57:15 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2024-01-25T05:00:02.874776175Z) 2026/02/21 04:57:15 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2026/02/21 04:57:15 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:15 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2026/02/21 04:57:15 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 04:57:15 INFO : file1.txt: Copied (new) 2026/02/21 04:57:15 DEBUG : Local file system at /tmp/045704yo/initdir/test_normalization-quwuhun2: Waiting for checks to finish 2026/02/21 04:57:15 DEBUG : Local file system at /tmp/045704yo/initdir/test_normalization-quwuhun2: Waiting for transfers to finish 2026/02/21 04:57:15 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.062d4dd7.partial: size = 0 OK 2026/02/21 04:57:15 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:15 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 04:57:15 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.062d4dd7.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file 2026/02/21 04:57:15 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.b8f49a2a.partial: size = 272 OK 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.b8f49a2a.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt 2026/02/21 04:57:15 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.24b96bc5.partial: size = 272 OK 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2026/02/21 04:57:15 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.24b96bc5.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt 2026/02/21 04:57:15 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2026/02/21 04:57:15 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2026/02/21 04:57:15 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_normalization/modfiles" 2026/02/21 04:57:15 DEBUG : Creating backend with remote "/tmp/045704yo/datadir/test_normalization-jixugec1" 2026/02/21 04:57:15 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:15 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:15 DEBUG : Local file system at /tmp/045704yo/datadir/test_normalization-jixugec1: Waiting for checks to finish 2026/02/21 04:57:15 DEBUG : Local file system at /tmp/045704yo/datadir/test_normalization-jixugec1: Waiting for transfers to finish 2026/02/21 04:57:15 DEBUG : 測試_filtersfile.txt.3ada41b4.partial: size = 254 OK 2026/02/21 04:57:15 DEBUG : file1.txt.75b77f44.partial: size = 19 OK 2026/02/21 04:57:15 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK 2026/02/21 04:57:15 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:57:15 DEBUG : 測試_filtersfile.txt.3ada41b4.partial: renamed to: 測試_filtersfile.txt 2026/02/21 04:57:15 INFO : 測試_filtersfile.txt: Copied (new) 2026/02/21 04:57:15 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt 2026/02/21 04:57:15 INFO : file1.txt: Copied (new) 2026/02/21 04:57:15 DEBUG : Waiting for deletions to finish 2026/02/21 04:57:15 ERROR : error listing: directory not found 2026/02/21 04:57:15 ERROR : Local file system at /tmp/045704yo/normalization/path1: Failed to list "": directory not found 2026/02/21 04:57:15 DEBUG : removing 1 level 0 directories 2026/02/21 04:57:15 INFO : Local file system at /tmp/045704yo/normalization/path1: Removing directory 2026/02/21 04:57:15 ERROR : Failed to rmdir: stat /tmp/045704yo/normalization/path1: no such file or directory 2026/02/21 04:57:15 DEBUG : Waiting for deletions to finish 2026/02/21 04:57:16 ERROR : error listing: directory not found 2026/02/21 04:57:16 ERROR : Internxt root 'rclone-test-jatexof5zonu/045704yo/normalization/path2': Failed to list "": directory not found 2026/02/21 04:57:16 DEBUG : removing 1 level 0 directories 2026/02/21 04:57:16 INFO : Internxt root 'rclone-test-jatexof5zonu/045704yo/normalization/path2': Removing directory 2026/02/21 04:57:16 ERROR : Failed to rmdir: directory not found 2026/02/21 04:57:16 ERROR : error listing: directory not found 2026/02/21 04:57:16 ERROR : error listing: directory not found 2026/02/21 04:57:16 NOTICE: checking initFs Local file system at /tmp/045704yo/initdir/test_normalization-quwuhun2 2026/02/21 04:57:16 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:57:16 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata 2026/02/21 04:57:16 INFO : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2024-01-25T05:00:02.874776175Z) 2026/02/21 04:57:16 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ 2026/02/21 04:57:16 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 04:57:16 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:16 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 04:57:16 INFO : file1.txt: Copied (new) 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2026/02/21 04:57:16 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 04:57:16 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:57:16 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.062d4dd7.partial: size = 0 OK 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.b8f49a2a.partial: size = 272 OK 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.062d4dd7.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file 2026/02/21 04:57:16 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.b8f49a2a.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt 2026/02/21 04:57:16 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2026/02/21 04:57:16 DEBUG : Local file system at /tmp/045704yo/normalization/path1: Waiting for checks to finish 2026/02/21 04:57:16 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:57:16 DEBUG : Local file system at /tmp/045704yo/normalization/path1: Waiting for transfers to finish 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.24b96bc5.partial: size = 272 OK 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK 2026/02/21 04:57:16 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.24b96bc5.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt 2026/02/21 04:57:16 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) 2026/02/21 04:57:16 INFO : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime) 2026/02/21 04:57:16 NOTICE: checking Path1 Local file system at /tmp/045704yo/normalization/path1 2026/02/21 04:57:16 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:57:16 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:16 INFO : 測試_Русский_ _ _ě_áñ: Making directory 2026/02/21 04:57:17 ERROR : file1.txt: Failed to copy: failed to make directory: can't create folder, create folder: Parent folder does not exist (status 404) 2026/02/21 04:57:17 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:17 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:17 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination 2026/02/21 04:57:17 DEBUG : Internxt root 'rclone-test-jatexof5zonu/045704yo/normalization/path2': Waiting for checks to finish 2026/02/21 04:57:17 DEBUG : Internxt root 'rclone-test-jatexof5zonu/045704yo/normalization/path2': Waiting for transfers to finish 2026/02/21 04:57:18 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: size = 0 OK 2026/02/21 04:57:18 INFO : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new) 2026/02/21 04:57:18 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 04:57:18 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:57:18 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: size = 272 OK 2026/02/21 04:57:18 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new) 2026/02/21 04:57:18 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: size = 272 OK 2026/02/21 04:57:18 INFO : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new) bisync_test.go:2013: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:2013 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:509 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Received unexpected error: failed to make directory: can't create folder, create folder: Parent folder does not exist (status 404) Test: TestBisyncLocalRemote/normalization Messages: setting up path2 2026/02/21 04:57:18 NOTICE: checking path2 Internxt root 'rclone-test-jatexof5zonu/045704yo/normalization/path2' fstest.go:298: Sleeping for 1s for list eventual consistency: 1/5 fstest.go:298: Sleeping for 2s for list eventual consistency: 2/5 fstest.go:298: Sleeping for 4s for list eventual consistency: 3/5 fstest.go:298: Sleeping for 8s for list eventual consistency: 4/5 fstest.go:298: Sleeping for 16s for list eventual consistency: 5/5 fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:511 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Should be true Test: TestBisyncLocalRemote/normalization Messages: listing wrong, want RCLONE_TEST (109), file1.txt (0), 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt (272), 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt (272), 測試_Русский_ _ _ě_áñ/測試_check file (0) got RCLONE_TEST (109), 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt (272), 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt (272), 測試_Русский_ _ _ě_áñ/測試_check file (0) fstest.go:203: Not found "file1.txt" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:511 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Not equal: expected: 0 actual : 1 Test: TestBisyncLocalRemote/normalization Messages: 1 objects not found 2026/02/21 04:57:51 NOTICE: (01) : test normalization 2026/02/21 04:57:51 NOTICE: (02) : touch-copy 2001-01-02 /tmp/045704yo/datadir/test_normalization-jixugec1/file1.txt TestInternxt:rclone-test-jatexof5zonu/045704yo/normalization/path2/ 2026/02/21 04:57:51 DEBUG : Creating backend with remote "/tmp/045704yo/datadir/test_normalization-jixugec1/" 2026/02/21 04:57:51 DEBUG : fs cache: renaming cache item "/tmp/045704yo/datadir/test_normalization-jixugec1/" to be canonical "/tmp/045704yo/datadir/test_normalization-jixugec1" 2026/02/21 04:57:51 DEBUG : file1.txt: Set modification time 2001-01-02 2026/02/21 04:57:51 DEBUG : copyFile "/tmp/045704yo/datadir/test_normalization-jixugec1/file1.txt" to "TestInternxt:rclone-test-jatexof5zonu/045704yo/normalization/path2/" as "" 2026/02/21 04:57:51 DEBUG : Creating backend with remote "/tmp/045704yo/datadir/test_normalization-jixugec1/file1.txt" 2026/02/21 04:57:51 DEBUG : Creating backend with remote "TestInternxt:rclone-test-jatexof5zonu/045704yo/normalization/path2/" 2026/02/21 04:57:52 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:57:52 DEBUG : operations.CopyFile "file1.txt" to "Internxt root 'rclone-test-jatexof5zonu/045704yo/normalization/path2'" as "file1.txt" 2026/02/21 04:57:52 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:57:54 DEBUG : file1.txt: size = 19 OK 2026/02/21 04:57:54 INFO : file1.txt: Copied (new) 2026/02/21 04:57:54 NOTICE: (03) : test initial bisync 2026/02/21 04:57:54 NOTICE: (04) : bisync resync bisync_test.go:1015: skipping test as at least one remote does not support setting modtime 2026/02/21 04:57:56 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/all_changed/path2/RCLONE_TEST" 2026/02/21 04:57:56 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/all_changed/path2/file1.copy1.txt" 2026/02/21 04:57:57 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/all_changed/path2/file1.copy2.txt" 2026/02/21 04:57:57 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/all_changed/path2/file1.copy3.txt" 2026/02/21 04:57:57 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/all_changed/path2/file1.copy4.txt" 2026/02/21 04:57:57 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/all_changed/path2/file1.copy5.txt" 2026/02/21 04:57:57 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/all_changed/path2/file1.txt" 2026/02/21 04:57:58 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/max_delete_path2_force/path2/file1.txt" 2026/02/21 04:57:58 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/max_delete_path2_force/path2/file2.txt" 2026/02/21 04:57:58 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/max_delete_path2_force/path2/file3.txt" 2026/02/21 04:57:58 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/max_delete_path2_force/path2/file4.txt" 2026/02/21 04:57:58 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/max_delete_path2_force/path2/file5.txt" 2026/02/21 04:57:58 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/max_delete_path2_force/path2/file6.txt" 2026/02/21 04:57:59 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/max_delete_path2_force/path2/file7.txt" 2026/02/21 04:57:59 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/max_delete_path2_force/path2/file8.txt" 2026/02/21 04:57:59 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/max_delete_path2_force/path2/file9.txt" 2026/02/21 04:57:59 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/normalization/path2/RCLONE_TEST" 2026/02/21 04:57:59 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/normalization/path2/file1.txt" 2026/02/21 04:58:00 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/all_changed/path2/subdir/file20.txt" 2026/02/21 04:58:00 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/normalization/path2/測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt" 2026/02/21 04:58:00 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/normalization/path2/測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt" 2026/02/21 04:58:00 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge object "045704yo/normalization/path2/測試_Русский_ _ _ě_áñ/測試_check file" 2026/02/21 04:58:01 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "045704yo/path2" 2026/02/21 04:58:01 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "045704yo/normalization/path2/測試_Русский_ _ _ě_áñ" 2026/02/21 04:58:01 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "045704yo/normalization/path2" 2026/02/21 04:58:01 NOTICE: purge failed to rmdir "045704yo/normalization/path2": directory not empty 2026/02/21 04:58:01 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "045704yo/normalization" 2026/02/21 04:58:01 NOTICE: purge failed to rmdir "045704yo/normalization": directory not empty 2026/02/21 04:58:01 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "045704yo/max_delete_path2_force/path2" 2026/02/21 04:58:02 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "045704yo/max_delete_path2_force" 2026/02/21 04:58:02 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "045704yo/all_changed/path2/subdir" 2026/02/21 04:58:02 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "045704yo/all_changed/path2" 2026/02/21 04:58:02 NOTICE: purge failed to rmdir "045704yo/all_changed/path2": directory not empty 2026/02/21 04:58:02 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "045704yo/all_changed" 2026/02/21 04:58:02 NOTICE: purge failed to rmdir "045704yo/all_changed": directory not empty 2026/02/21 04:58:02 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "045704yo" 2026/02/21 04:58:03 NOTICE: purge failed to rmdir "045704yo": directory not empty 2026/02/21 04:58:03 DEBUG : Internxt root 'rclone-test-jatexof5zonu': Purge dir "" 2026/02/21 04:58:03 NOTICE: purge failed to rmdir "": directory not empty --- FAIL: TestBisyncLocalRemote (59.28s) --- SKIP: TestBisyncLocalRemote/all_changed (5.83s) --- SKIP: TestBisyncLocalRemote/max_delete_path2_force (4.38s) --- FAIL: TestBisyncLocalRemote/normalization (39.80s) === RUN TestBisyncRemoteRemote 2026/02/21 04:58:03 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi" 2026/02/21 04:58:03 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:58:03 NOTICE: remote: TestInternxt:rclone-test-cucoyut6qixi === RUN TestBisyncRemoteRemote/changes 2026/02/21 04:58:03 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co" 2026/02/21 04:58:04 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:58:04 INFO : path1: Making directory bisync_test.go:2013: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:2013 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:639 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:432 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Received unexpected error: failed to make directory: can't create folder, create folder: Parent folder does not exist (status 404) Test: TestBisyncRemoteRemote/changes Messages: Mkdir path1 2026/02/21 04:58:04 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/changes/path1" 2026/02/21 04:58:05 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:58:05 INFO : path2: Making directory 2026/02/21 04:58:06 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/changes/path2" 2026/02/21 04:58:06 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:58:06 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_changes/initial" 2026/02/21 04:58:06 DEBUG : Creating backend with remote "/tmp/045803co/initdir/test_changes-nubufeb3" 2026/02/21 04:58:06 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 04:58:06 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:06 DEBUG : Local file system at /tmp/045803co/initdir/test_changes-nubufeb3: Waiting for checks to finish 2026/02/21 04:58:06 DEBUG : Local file system at /tmp/045803co/initdir/test_changes-nubufeb3: Waiting for transfers to finish 2026/02/21 04:58:06 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2026/02/21 04:58:06 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 04:58:06 INFO : file1.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:06 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 04:58:06 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2026/02/21 04:58:06 INFO : file3.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2026/02/21 04:58:06 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:06 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:06 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2026/02/21 04:58:06 INFO : file4.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2026/02/21 04:58:06 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:06 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 04:58:06 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:58:06 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 04:58:06 INFO : file2.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2026/02/21 04:58:06 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2026/02/21 04:58:06 INFO : file5.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2026/02/21 04:58:06 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:06 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 04:58:06 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:58:06 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:06 DEBUG : file8.txt.b300b322.partial: size = 0 OK 2026/02/21 04:58:06 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2026/02/21 04:58:06 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2026/02/21 04:58:06 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:06 INFO : file6.txt: Copied (new) 2026/02/21 04:58:06 INFO : file7.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt 2026/02/21 04:58:06 INFO : file8.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_changes/modfiles" 2026/02/21 04:58:06 DEBUG : Creating backend with remote "/tmp/045803co/datadir/test_changes-zoxotej7" 2026/02/21 04:58:06 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file10.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file11.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:06 DEBUG : Local file system at /tmp/045803co/datadir/test_changes-zoxotej7: Waiting for checks to finish 2026/02/21 04:58:06 DEBUG : Local file system at /tmp/045803co/datadir/test_changes-zoxotej7: Waiting for transfers to finish 2026/02/21 04:58:06 DEBUG : file1.txt.75b77f44.partial: size = 19 OK 2026/02/21 04:58:06 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:58:06 DEBUG : file10.txt.c02780cb.partial: size = 19 OK 2026/02/21 04:58:06 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:58:06 DEBUG : file11.txt.40d797d4.partial: size = 19 OK 2026/02/21 04:58:06 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:58:06 DEBUG : file10.txt.c02780cb.partial: renamed to: file10.txt 2026/02/21 04:58:06 INFO : file10.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file1.txt.75b77f44.partial: renamed to: file1.txt 2026/02/21 04:58:06 INFO : file1.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file11.txt.40d797d4.partial: renamed to: file11.txt 2026/02/21 04:58:06 INFO : file11.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file2.txt.4526d70e.partial: size = 13 OK 2026/02/21 04:58:06 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2026/02/21 04:58:06 DEBUG : file2.txt.4526d70e.partial: renamed to: file2.txt 2026/02/21 04:58:06 INFO : file2.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file6.txt.4185169b.partial: size = 19 OK 2026/02/21 04:58:06 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:58:06 DEBUG : file5R.txt.ee3b9525.partial: size = 39 OK 2026/02/21 04:58:06 DEBUG : file6.txt.4185169b.partial: renamed to: file6.txt 2026/02/21 04:58:06 INFO : file6.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2026/02/21 04:58:06 DEBUG : file7.txt.c1750184.partial: size = 19 OK 2026/02/21 04:58:06 DEBUG : file5R.txt.ee3b9525.partial: renamed to: file5R.txt 2026/02/21 04:58:06 INFO : file5R.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:58:06 DEBUG : file7.txt.c1750184.partial: renamed to: file7.txt 2026/02/21 04:58:06 INFO : file7.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : file5L.txt.8dd6541a.partial: size = 39 OK 2026/02/21 04:58:06 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2026/02/21 04:58:06 DEBUG : file5L.txt.8dd6541a.partial: renamed to: file5L.txt 2026/02/21 04:58:06 INFO : file5L.txt: Copied (new) 2026/02/21 04:58:06 DEBUG : Waiting for deletions to finish 2026/02/21 04:58:07 ERROR : error listing: directory not found 2026/02/21 04:58:07 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/changes/path1': Failed to list "": directory not found 2026/02/21 04:58:07 DEBUG : removing 1 level 0 directories 2026/02/21 04:58:07 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/changes/path1': Removing directory 2026/02/21 04:58:07 ERROR : Failed to rmdir: directory not found 2026/02/21 04:58:07 DEBUG : Waiting for deletions to finish 2026/02/21 04:58:07 ERROR : error listing: directory not found 2026/02/21 04:58:07 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/changes/path2': Failed to list "": directory not found 2026/02/21 04:58:07 DEBUG : removing 1 level 0 directories 2026/02/21 04:58:07 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/changes/path2': Removing directory 2026/02/21 04:58:07 ERROR : Failed to rmdir: directory not found 2026/02/21 04:58:07 ERROR : error listing: directory not found 2026/02/21 04:58:07 ERROR : error listing: directory not found 2026/02/21 04:58:07 NOTICE: checking initFs Local file system at /tmp/045803co/initdir/test_changes-nubufeb3 2026/02/21 04:58:08 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:58:08 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:08 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:08 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:08 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:08 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:08 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:08 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:08 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:08 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/changes/path1': Waiting for checks to finish 2026/02/21 04:58:08 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/changes/path1': Waiting for transfers to finish 2026/02/21 04:58:08 ERROR : RCLONE_TEST: Failed to copy: failed to make directory: can't create folder, create folder: Parent folder does not exist (status 404) 2026/02/21 04:58:09 ERROR : file3.txt: Failed to copy: failed to create empty file metadata: create meta: Folder not found (status 404) 2026/02/21 04:58:09 ERROR : file1.txt: Failed to copy: failed to create empty file metadata: create meta: Folder not found (status 404) 2026/02/21 04:58:09 ERROR : file4.txt: Failed to copy: failed to create empty file metadata: create meta: Folder not found (status 404) 2026/02/21 04:58:09 ERROR : file2.txt: Failed to copy: failed to create empty file metadata: create meta: Folder not found (status 404) 2026/02/21 04:58:09 DEBUG : file5.txt: size = 0 OK 2026/02/21 04:58:09 INFO : file5.txt: Copied (new) 2026/02/21 04:58:09 DEBUG : file6.txt: size = 0 OK 2026/02/21 04:58:09 INFO : file6.txt: Copied (new) 2026/02/21 04:58:09 DEBUG : file7.txt: size = 0 OK 2026/02/21 04:58:09 INFO : file7.txt: Copied (new) 2026/02/21 04:58:09 DEBUG : file8.txt: size = 0 OK 2026/02/21 04:58:09 INFO : file8.txt: Copied (new) bisync_test.go:2013: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:2013 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:506 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Received unexpected error: failed to create empty file metadata: create meta: Folder not found (status 404) Test: TestBisyncRemoteRemote/changes Messages: setting up path1 2026/02/21 04:58:09 NOTICE: checking Path1 Internxt root 'rclone-test-cucoyut6qixi/045803co/changes/path1' fstest.go:298: Sleeping for 1s for list eventual consistency: 1/5 fstest.go:298: Sleeping for 2s for list eventual consistency: 2/5 fstest.go:298: Sleeping for 4s for list eventual consistency: 3/5 fstest.go:298: Sleeping for 8s for list eventual consistency: 4/5 fstest.go:298: Sleeping for 16s for list eventual consistency: 5/5 fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:508 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Should be true Test: TestBisyncRemoteRemote/changes Messages: listing wrong, want RCLONE_TEST (109), file1.txt (0), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0) got file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0) fstest.go:203: Not found "file2.txt" fstest.go:203: Not found "file3.txt" fstest.go:203: Not found "file4.txt" fstest.go:203: Not found "RCLONE_TEST" fstest.go:203: Not found "file1.txt" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:508 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Not equal: expected: 0 actual : 5 Test: TestBisyncRemoteRemote/changes Messages: 5 objects not found 2026/02/21 04:58:41 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:58:41 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:41 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:41 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:41 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:41 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:41 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:41 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:41 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:41 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/changes/path2': Waiting for checks to finish 2026/02/21 04:58:41 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/changes/path2': Waiting for transfers to finish 2026/02/21 04:58:42 DEBUG : file1.txt: size = 0 OK 2026/02/21 04:58:42 INFO : file1.txt: Copied (new) 2026/02/21 04:58:42 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 04:58:42 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:58:43 DEBUG : file3.txt: size = 0 OK 2026/02/21 04:58:43 INFO : file3.txt: Copied (new) 2026/02/21 04:58:43 DEBUG : file2.txt: size = 0 OK 2026/02/21 04:58:43 INFO : file2.txt: Copied (new) 2026/02/21 04:58:43 DEBUG : file4.txt: size = 0 OK 2026/02/21 04:58:43 INFO : file4.txt: Copied (new) 2026/02/21 04:58:43 DEBUG : file5.txt: size = 0 OK 2026/02/21 04:58:43 INFO : file5.txt: Copied (new) 2026/02/21 04:58:43 DEBUG : file7.txt: size = 0 OK 2026/02/21 04:58:43 INFO : file7.txt: Copied (new) 2026/02/21 04:58:44 DEBUG : file6.txt: size = 0 OK 2026/02/21 04:58:44 INFO : file6.txt: Copied (new) 2026/02/21 04:58:44 DEBUG : file8.txt: size = 0 OK 2026/02/21 04:58:44 INFO : file8.txt: Copied (new) 2026/02/21 04:58:44 NOTICE: checking path2 Internxt root 'rclone-test-cucoyut6qixi/045803co/changes/path2' 2026/02/21 04:58:44 NOTICE: (01) : test changes 2026/02/21 04:58:44 NOTICE: (02) : test initial bisync 2026/02/21 04:58:44 NOTICE: (03) : bisync resync bisync_test.go:1015: skipping test as at least one remote does not support setting modtime === RUN TestBisyncRemoteRemote/concurrent 2026/02/21 04:58:44 INFO : path1: Making directory 2026/02/21 04:58:44 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/concurrent/path1" 2026/02/21 04:58:45 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:58:46 INFO : path2: Making directory 2026/02/21 04:58:46 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/concurrent/path2" 2026/02/21 04:58:46 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:58:47 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_concurrent/initial" 2026/02/21 04:58:47 DEBUG : Creating backend with remote "/tmp/045803co/initdir/test_concurrent-cimifen7" 2026/02/21 04:58:47 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2026/02/21 04:58:47 DEBUG : Local file system at /tmp/045803co/initdir/test_concurrent-cimifen7: Waiting for checks to finish 2026/02/21 04:58:47 DEBUG : Local file system at /tmp/045803co/initdir/test_concurrent-cimifen7: Waiting for transfers to finish 2026/02/21 04:58:47 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 04:58:47 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:47 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:47 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 04:58:47 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2026/02/21 04:58:47 INFO : file3.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 04:58:47 INFO : file1.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:47 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 04:58:47 INFO : file2.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2026/02/21 04:58:47 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2026/02/21 04:58:47 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:47 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2026/02/21 04:58:47 INFO : file6.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2026/02/21 04:58:47 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:47 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2026/02/21 04:58:47 INFO : file7.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file8.txt.b300b322.partial: size = 0 OK 2026/02/21 04:58:47 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:47 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt 2026/02/21 04:58:47 INFO : file8.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2026/02/21 04:58:47 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:47 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:47 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2026/02/21 04:58:47 INFO : file4.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2026/02/21 04:58:47 INFO : file5.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 04:58:47 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:58:47 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 04:58:47 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:58:47 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_concurrent/modfiles" 2026/02/21 04:58:47 DEBUG : Creating backend with remote "/tmp/045803co/datadir/test_concurrent-hegiweq1" 2026/02/21 04:58:47 DEBUG : dummy.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file10.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file11.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file5L.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file5R.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:47 DEBUG : dummy.txt.054c2352.partial: size = 0 OK 2026/02/21 04:58:47 DEBUG : Local file system at /tmp/045803co/datadir/test_concurrent-hegiweq1: Waiting for checks to finish 2026/02/21 04:58:47 DEBUG : Local file system at /tmp/045803co/datadir/test_concurrent-hegiweq1: Waiting for transfers to finish 2026/02/21 04:58:47 DEBUG : dummy.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:58:47 DEBUG : dummy.txt.054c2352.partial: renamed to: dummy.txt 2026/02/21 04:58:47 INFO : dummy.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file10.txt.0bea3133.partial: size = 19 OK 2026/02/21 04:58:47 DEBUG : file11.txt.62933a56.partial: size = 19 OK 2026/02/21 04:58:47 DEBUG : file1.txt.0866bb02.partial: size = 19 OK 2026/02/21 04:58:47 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:58:47 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:58:47 DEBUG : file10.txt.0bea3133.partial: renamed to: file10.txt 2026/02/21 04:58:47 INFO : file10.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file2.txt.95cb1da2.partial: size = 13 OK 2026/02/21 04:58:47 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK 2026/02/21 04:58:47 DEBUG : file2.txt.95cb1da2.partial: renamed to: file2.txt 2026/02/21 04:58:47 INFO : file2.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file1.txt.0866bb02.partial: renamed to: file1.txt 2026/02/21 04:58:47 INFO : file1.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:58:47 DEBUG : file11.txt.62933a56.partial: renamed to: file11.txt 2026/02/21 04:58:47 INFO : file11.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file6.txt.cd788d78.partial: size = 19 OK 2026/02/21 04:58:47 DEBUG : file5L.txt.0068aeca.partial: size = 39 OK 2026/02/21 04:58:47 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:58:47 DEBUG : file6.txt.cd788d78.partial: renamed to: file6.txt 2026/02/21 04:58:47 DEBUG : file5R.txt.70006d6a.partial: size = 39 OK 2026/02/21 04:58:47 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK 2026/02/21 04:58:47 INFO : file6.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file5L.txt.0068aeca.partial: renamed to: file5L.txt 2026/02/21 04:58:47 INFO : file5L.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file7.txt.a401861d.partial: size = 19 OK 2026/02/21 04:58:47 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK 2026/02/21 04:58:47 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 04:58:47 DEBUG : file7.txt.a401861d.partial: renamed to: file7.txt 2026/02/21 04:58:47 INFO : file7.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : file5R.txt.70006d6a.partial: renamed to: file5R.txt 2026/02/21 04:58:47 INFO : file5R.txt: Copied (new) 2026/02/21 04:58:47 DEBUG : Waiting for deletions to finish 2026/02/21 04:58:47 ERROR : error listing: directory not found 2026/02/21 04:58:47 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/concurrent/path1': Failed to list "": directory not found 2026/02/21 04:58:47 DEBUG : removing 1 level 0 directories 2026/02/21 04:58:47 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/concurrent/path1': Removing directory 2026/02/21 04:58:47 ERROR : Failed to rmdir: directory not found 2026/02/21 04:58:47 DEBUG : Waiting for deletions to finish 2026/02/21 04:58:47 ERROR : error listing: directory not found 2026/02/21 04:58:47 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/concurrent/path2': Failed to list "": directory not found 2026/02/21 04:58:47 DEBUG : removing 1 level 0 directories 2026/02/21 04:58:47 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/concurrent/path2': Removing directory 2026/02/21 04:58:47 ERROR : Failed to rmdir: directory not found 2026/02/21 04:58:48 ERROR : error listing: directory not found 2026/02/21 04:58:48 ERROR : error listing: directory not found 2026/02/21 04:58:48 NOTICE: checking initFs Local file system at /tmp/045803co/initdir/test_concurrent-cimifen7 2026/02/21 04:58:48 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:58:48 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:48 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:48 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:48 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:48 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:48 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:48 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:48 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:48 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/concurrent/path1': Waiting for checks to finish 2026/02/21 04:58:48 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/concurrent/path1': Waiting for transfers to finish 2026/02/21 04:58:49 DEBUG : file3.txt: size = 0 OK 2026/02/21 04:58:49 INFO : file3.txt: Copied (new) 2026/02/21 04:58:49 DEBUG : file1.txt: size = 0 OK 2026/02/21 04:58:49 INFO : file1.txt: Copied (new) 2026/02/21 04:58:49 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 04:58:49 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:58:49 DEBUG : file4.txt: size = 0 OK 2026/02/21 04:58:49 INFO : file4.txt: Copied (new) 2026/02/21 04:58:49 DEBUG : file5.txt: size = 0 OK 2026/02/21 04:58:49 INFO : file5.txt: Copied (new) 2026/02/21 04:58:49 DEBUG : file7.txt: size = 0 OK 2026/02/21 04:58:49 INFO : file7.txt: Copied (new) 2026/02/21 04:58:49 DEBUG : file2.txt: size = 0 OK 2026/02/21 04:58:49 INFO : file2.txt: Copied (new) 2026/02/21 04:58:49 DEBUG : file6.txt: size = 0 OK 2026/02/21 04:58:49 INFO : file6.txt: Copied (new) 2026/02/21 04:58:49 DEBUG : file8.txt: size = 0 OK 2026/02/21 04:58:49 INFO : file8.txt: Copied (new) 2026/02/21 04:58:49 NOTICE: checking Path1 Internxt root 'rclone-test-cucoyut6qixi/045803co/concurrent/path1' 2026/02/21 04:58:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:58:50 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:50 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:50 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:50 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:50 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:50 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:50 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:50 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 04:58:50 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/concurrent/path2': Waiting for checks to finish 2026/02/21 04:58:50 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/concurrent/path2': Waiting for transfers to finish 2026/02/21 04:58:51 ERROR : file1.txt: Failed to copy: failed to create empty file metadata: create meta: Folder not found (status 404) 2026/02/21 04:58:51 DEBUG : file2.txt: size = 0 OK 2026/02/21 04:58:51 INFO : file2.txt: Copied (new) 2026/02/21 04:58:51 DEBUG : file3.txt: size = 0 OK 2026/02/21 04:58:51 INFO : file3.txt: Copied (new) 2026/02/21 04:58:51 DEBUG : file6.txt: size = 0 OK 2026/02/21 04:58:51 INFO : file6.txt: Copied (new) 2026/02/21 04:58:51 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 04:58:51 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:58:51 DEBUG : file7.txt: size = 0 OK 2026/02/21 04:58:51 INFO : file7.txt: Copied (new) 2026/02/21 04:58:51 DEBUG : file5.txt: size = 0 OK 2026/02/21 04:58:51 INFO : file5.txt: Copied (new) 2026/02/21 04:58:51 DEBUG : file4.txt: size = 0 OK 2026/02/21 04:58:51 INFO : file4.txt: Copied (new) 2026/02/21 04:58:51 DEBUG : file8.txt: size = 0 OK 2026/02/21 04:58:51 INFO : file8.txt: Copied (new) bisync_test.go:2013: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:2013 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:509 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Received unexpected error: failed to create empty file metadata: create meta: Folder not found (status 404) Test: TestBisyncRemoteRemote/concurrent Messages: setting up path2 2026/02/21 04:58:51 NOTICE: checking path2 Internxt root 'rclone-test-cucoyut6qixi/045803co/concurrent/path2' fstest.go:298: Sleeping for 1s for list eventual consistency: 1/5 fstest.go:298: Sleeping for 2s for list eventual consistency: 2/5 fstest.go:298: Sleeping for 4s for list eventual consistency: 3/5 fstest.go:298: Sleeping for 8s for list eventual consistency: 4/5 fstest.go:298: Sleeping for 16s for list eventual consistency: 5/5 fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:511 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Should be true Test: TestBisyncRemoteRemote/concurrent Messages: listing wrong, want RCLONE_TEST (109), file1.txt (0), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0) got RCLONE_TEST (109), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0) fstest.go:203: Not found "file1.txt" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:511 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Not equal: expected: 0 actual : 1 Test: TestBisyncRemoteRemote/concurrent Messages: 1 objects not found 2026/02/21 04:59:24 NOTICE: (01) : test concurrent 2026/02/21 04:59:24 NOTICE: (02) : test initial bisync 2026/02/21 04:59:24 NOTICE: (03) : bisync resync bisync_test.go:1015: skipping test as at least one remote does not support setting modtime === RUN TestBisyncRemoteRemote/equal 2026/02/21 04:59:24 INFO : path1: Making directory 2026/02/21 04:59:24 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/equal/path1" 2026/02/21 04:59:24 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:59:25 INFO : path2: Making directory 2026/02/21 04:59:25 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/equal/path2" 2026/02/21 04:59:25 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 04:59:26 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_equal/initial" 2026/02/21 04:59:26 DEBUG : Creating backend with remote "/tmp/045803co/initdir/test_equal-zelopof6" 2026/02/21 04:59:26 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:59:26 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:59:26 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:59:26 DEBUG : Local file system at /tmp/045803co/initdir/test_equal-zelopof6: Waiting for checks to finish 2026/02/21 04:59:26 DEBUG : Local file system at /tmp/045803co/initdir/test_equal-zelopof6: Waiting for transfers to finish 2026/02/21 04:59:26 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 04:59:26 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 04:59:26 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:59:26 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 04:59:26 INFO : file2.txt: Copied (new) 2026/02/21 04:59:26 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 04:59:26 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 04:59:26 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:59:26 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 04:59:26 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 04:59:26 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 04:59:26 INFO : file1.txt: Copied (new) 2026/02/21 04:59:26 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_equal/modfiles" 2026/02/21 04:59:26 DEBUG : Creating backend with remote "/tmp/045803co/datadir/test_equal-buwiyus7" 2026/02/21 04:59:26 DEBUG : file1L.txt: Need to transfer - File not found at Destination 2026/02/21 04:59:26 DEBUG : file1R.txt: Need to transfer - File not found at Destination 2026/02/21 04:59:26 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:59:26 DEBUG : Local file system at /tmp/045803co/datadir/test_equal-buwiyus7: Waiting for checks to finish 2026/02/21 04:59:26 DEBUG : Local file system at /tmp/045803co/datadir/test_equal-buwiyus7: Waiting for transfers to finish 2026/02/21 04:59:26 DEBUG : file1L.txt.bc963e7b.partial: size = 33 OK 2026/02/21 04:59:26 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK 2026/02/21 04:59:26 DEBUG : file1L.txt.bc963e7b.partial: renamed to: file1L.txt 2026/02/21 04:59:26 INFO : file1L.txt: Copied (new) 2026/02/21 04:59:26 DEBUG : file2.txt.467c795f.partial: size = 37 OK 2026/02/21 04:59:26 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK 2026/02/21 04:59:26 DEBUG : file1R.txt.df7bff44.partial: size = 33 OK 2026/02/21 04:59:26 DEBUG : file2.txt.467c795f.partial: renamed to: file2.txt 2026/02/21 04:59:26 INFO : file2.txt: Copied (new) 2026/02/21 04:59:26 DEBUG : file1R.txt: md5 = 2b4975bb20f7be674e66d78570ba2fb1 OK 2026/02/21 04:59:26 DEBUG : file1R.txt.df7bff44.partial: renamed to: file1R.txt 2026/02/21 04:59:26 INFO : file1R.txt: Copied (new) 2026/02/21 04:59:26 DEBUG : Waiting for deletions to finish 2026/02/21 04:59:26 ERROR : error listing: directory not found 2026/02/21 04:59:26 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/equal/path1': Failed to list "": directory not found 2026/02/21 04:59:26 DEBUG : removing 1 level 0 directories 2026/02/21 04:59:26 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/equal/path1': Removing directory 2026/02/21 04:59:26 ERROR : Failed to rmdir: directory not found 2026/02/21 04:59:26 DEBUG : Waiting for deletions to finish 2026/02/21 04:59:26 ERROR : error listing: directory not found 2026/02/21 04:59:26 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/equal/path2': Failed to list "": directory not found 2026/02/21 04:59:26 DEBUG : removing 1 level 0 directories 2026/02/21 04:59:26 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/equal/path2': Removing directory 2026/02/21 04:59:27 ERROR : Failed to rmdir: directory not found 2026/02/21 04:59:27 ERROR : error listing: directory not found 2026/02/21 04:59:27 ERROR : error listing: directory not found 2026/02/21 04:59:27 NOTICE: checking initFs Local file system at /tmp/045803co/initdir/test_equal-zelopof6 2026/02/21 04:59:27 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:59:27 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:59:27 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:59:27 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/equal/path1': Waiting for checks to finish 2026/02/21 04:59:27 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/equal/path1': Waiting for transfers to finish 2026/02/21 04:59:28 DEBUG : file2.txt: size = 0 OK 2026/02/21 04:59:28 INFO : file2.txt: Copied (new) 2026/02/21 04:59:28 DEBUG : file1.txt: size = 0 OK 2026/02/21 04:59:28 INFO : file1.txt: Copied (new) 2026/02/21 04:59:28 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 04:59:28 INFO : RCLONE_TEST: Copied (new) 2026/02/21 04:59:28 NOTICE: checking Path1 Internxt root 'rclone-test-cucoyut6qixi/045803co/equal/path1' 2026/02/21 04:59:29 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 04:59:29 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 04:59:29 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 04:59:29 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/equal/path2': Waiting for checks to finish 2026/02/21 04:59:29 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/equal/path2': Waiting for transfers to finish 2026/02/21 04:59:29 ERROR : file1.txt: Failed to copy: failed to create empty file metadata: create meta: Folder not found (status 404) 2026/02/21 04:59:29 DEBUG : file2.txt: size = 0 OK 2026/02/21 04:59:29 INFO : file2.txt: Copied (new) 2026/02/21 04:59:30 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 04:59:30 INFO : RCLONE_TEST: Copied (new) bisync_test.go:2013: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:2013 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:509 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Received unexpected error: failed to create empty file metadata: create meta: Folder not found (status 404) Test: TestBisyncRemoteRemote/equal Messages: setting up path2 2026/02/21 04:59:30 NOTICE: checking path2 Internxt root 'rclone-test-cucoyut6qixi/045803co/equal/path2' fstest.go:298: Sleeping for 1s for list eventual consistency: 1/5 fstest.go:298: Sleeping for 2s for list eventual consistency: 2/5 fstest.go:298: Sleeping for 4s for list eventual consistency: 3/5 fstest.go:298: Sleeping for 8s for list eventual consistency: 4/5 fstest.go:298: Sleeping for 16s for list eventual consistency: 5/5 fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:511 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Should be true Test: TestBisyncRemoteRemote/equal Messages: listing wrong, want RCLONE_TEST (109), file1.txt (0), file2.txt (0) got RCLONE_TEST (109), file2.txt (0) fstest.go:203: Not found "file1.txt" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:511 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Not equal: expected: 0 actual : 1 Test: TestBisyncRemoteRemote/equal Messages: 1 objects not found 2026/02/21 05:00:02 NOTICE: (01) : test equal 2026/02/21 05:00:02 NOTICE: (02) : test initial bisync 2026/02/21 05:00:02 NOTICE: (03) : bisync resync bisync_test.go:1015: skipping test as at least one remote does not support setting modtime === RUN TestBisyncRemoteRemote/filters 2026/02/21 05:00:02 INFO : path1: Making directory 2026/02/21 05:00:02 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/filters/path1" 2026/02/21 05:00:02 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 05:00:03 INFO : path2: Making directory 2026/02/21 05:00:03 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/filters/path2" 2026/02/21 05:00:03 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 05:00:04 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_filters/initial" 2026/02/21 05:00:04 DEBUG : Creating backend with remote "/tmp/045803co/initdir/test_filters-wimelin3" 2026/02/21 05:00:04 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : subdir: Making directory with metadata 2026/02/21 05:00:04 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2026/02/21 05:00:04 DEBUG : Added delayed dir = "subdir", newDst=subdir 2026/02/21 05:00:04 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : Local file system at /tmp/045803co/initdir/test_filters-wimelin3: Waiting for checks to finish 2026/02/21 05:00:04 DEBUG : Local file system at /tmp/045803co/initdir/test_filters-wimelin3: Waiting for transfers to finish 2026/02/21 05:00:04 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 05:00:04 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:04 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 05:00:04 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:04 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2026/02/21 05:00:04 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:04 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 05:00:04 INFO : file1.txt: Copied (new) 2026/02/21 05:00:04 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 05:00:04 INFO : file2.txt: Copied (new) 2026/02/21 05:00:04 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2026/02/21 05:00:04 INFO : file3.txt: Copied (new) 2026/02/21 05:00:04 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2026/02/21 05:00:04 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:04 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2026/02/21 05:00:04 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2026/02/21 05:00:04 INFO : file4.txt: Copied (new) 2026/02/21 05:00:04 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 05:00:04 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2026/02/21 05:00:04 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:04 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:04 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 05:00:04 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2026/02/21 05:00:04 INFO : file5.txt: Copied (new) 2026/02/21 05:00:04 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 05:00:04 INFO : RCLONE_TEST: Copied (new) 2026/02/21 05:00:04 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2026/02/21 05:00:04 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2026/02/21 05:00:04 INFO : file6.txt: Copied (new) 2026/02/21 05:00:04 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:04 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2026/02/21 05:00:04 INFO : file7.txt: Copied (new) 2026/02/21 05:00:04 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK 2026/02/21 05:00:04 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:04 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt 2026/02/21 05:00:04 INFO : subdir/file20.txt: Copied (new) 2026/02/21 05:00:04 INFO : subdir: Set directory modification time (using SetModTime) 2026/02/21 05:00:04 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_filters/modfiles" 2026/02/21 05:00:04 DEBUG : Creating backend with remote "/tmp/045803co/datadir/test_filters-rufozoq5" 2026/02/21 05:00:04 DEBUG : fileZ.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : filtersfile.flt: Need to transfer - File not found at Destination 2026/02/21 05:00:04 DEBUG : Local file system at /tmp/045803co/datadir/test_filters-rufozoq5: Waiting for checks to finish 2026/02/21 05:00:04 DEBUG : Local file system at /tmp/045803co/datadir/test_filters-rufozoq5: Waiting for transfers to finish 2026/02/21 05:00:04 DEBUG : filtersfile.flt.e46c0e4d.partial: size = 254 OK 2026/02/21 05:00:04 DEBUG : filtersfile.flt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK 2026/02/21 05:00:04 DEBUG : filtersfile.flt.e46c0e4d.partial: renamed to: filtersfile.flt 2026/02/21 05:00:04 INFO : filtersfile.flt: Copied (new) 2026/02/21 05:00:04 DEBUG : fileZ.txt.64882095.partial: size = 19 OK 2026/02/21 05:00:04 DEBUG : fileZ.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 05:00:04 DEBUG : fileZ.txt.64882095.partial: renamed to: fileZ.txt 2026/02/21 05:00:04 INFO : fileZ.txt: Copied (new) 2026/02/21 05:00:04 DEBUG : Waiting for deletions to finish 2026/02/21 05:00:04 ERROR : error listing: directory not found 2026/02/21 05:00:04 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/filters/path1': Failed to list "": directory not found 2026/02/21 05:00:04 DEBUG : removing 1 level 0 directories 2026/02/21 05:00:04 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/filters/path1': Removing directory 2026/02/21 05:00:04 ERROR : Failed to rmdir: directory not found 2026/02/21 05:00:04 DEBUG : Waiting for deletions to finish 2026/02/21 05:00:05 ERROR : error listing: directory not found 2026/02/21 05:00:05 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/filters/path2': Failed to list "": directory not found 2026/02/21 05:00:05 DEBUG : removing 1 level 0 directories 2026/02/21 05:00:05 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/filters/path2': Removing directory 2026/02/21 05:00:05 ERROR : Failed to rmdir: directory not found 2026/02/21 05:00:05 ERROR : error listing: directory not found 2026/02/21 05:00:05 ERROR : error listing: directory not found 2026/02/21 05:00:05 NOTICE: checking initFs Local file system at /tmp/045803co/initdir/test_filters-wimelin3 2026/02/21 05:00:05 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 05:00:05 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:05 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:05 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:05 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:05 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:05 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:05 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:05 INFO : subdir: Making directory 2026/02/21 05:00:06 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:06 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/filters/path1': Waiting for checks to finish 2026/02/21 05:00:06 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/filters/path1': Waiting for transfers to finish 2026/02/21 05:00:06 DEBUG : file2.txt: size = 0 OK 2026/02/21 05:00:06 INFO : file2.txt: Copied (new) 2026/02/21 05:00:06 DEBUG : file3.txt: size = 0 OK 2026/02/21 05:00:06 INFO : file3.txt: Copied (new) 2026/02/21 05:00:06 DEBUG : file4.txt: size = 0 OK 2026/02/21 05:00:06 INFO : file4.txt: Copied (new) 2026/02/21 05:00:07 DEBUG : file5.txt: size = 0 OK 2026/02/21 05:00:07 INFO : file5.txt: Copied (new) 2026/02/21 05:00:07 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 05:00:07 INFO : RCLONE_TEST: Copied (new) 2026/02/21 05:00:07 DEBUG : file6.txt: size = 0 OK 2026/02/21 05:00:07 INFO : file6.txt: Copied (new) 2026/02/21 05:00:07 DEBUG : file7.txt: size = 0 OK 2026/02/21 05:00:07 INFO : file7.txt: Copied (new) 2026/02/21 05:00:07 DEBUG : subdir/file20.txt: size = 0 OK 2026/02/21 05:00:07 INFO : subdir/file20.txt: Copied (new) 2026/02/21 05:00:07 DEBUG : file1.txt: size = 0 OK 2026/02/21 05:00:07 INFO : file1.txt: Copied (new) 2026/02/21 05:00:07 NOTICE: checking Path1 Internxt root 'rclone-test-cucoyut6qixi/045803co/filters/path1' 2026/02/21 05:00:08 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 05:00:08 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:08 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:08 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:08 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:08 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:08 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:08 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:08 INFO : subdir: Making directory 2026/02/21 05:00:09 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:09 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/filters/path2': Waiting for checks to finish 2026/02/21 05:00:09 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/filters/path2': Waiting for transfers to finish 2026/02/21 05:00:09 DEBUG : file2.txt: size = 0 OK 2026/02/21 05:00:09 INFO : file2.txt: Copied (new) 2026/02/21 05:00:09 DEBUG : file1.txt: size = 0 OK 2026/02/21 05:00:09 INFO : file1.txt: Copied (new) 2026/02/21 05:00:09 DEBUG : file4.txt: size = 0 OK 2026/02/21 05:00:09 INFO : file4.txt: Copied (new) 2026/02/21 05:00:09 DEBUG : file5.txt: size = 0 OK 2026/02/21 05:00:09 INFO : file5.txt: Copied (new) 2026/02/21 05:00:09 DEBUG : file6.txt: size = 0 OK 2026/02/21 05:00:09 INFO : file6.txt: Copied (new) 2026/02/21 05:00:09 DEBUG : file3.txt: size = 0 OK 2026/02/21 05:00:09 INFO : file3.txt: Copied (new) 2026/02/21 05:00:09 DEBUG : file7.txt: size = 0 OK 2026/02/21 05:00:09 INFO : file7.txt: Copied (new) 2026/02/21 05:00:10 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 05:00:10 INFO : RCLONE_TEST: Copied (new) 2026/02/21 05:00:10 DEBUG : subdir/file20.txt: size = 0 OK 2026/02/21 05:00:10 INFO : subdir/file20.txt: Copied (new) 2026/02/21 05:00:10 NOTICE: checking path2 Internxt root 'rclone-test-cucoyut6qixi/045803co/filters/path2' 2026/02/21 05:00:11 NOTICE: (01) : test filters 2026/02/21 05:00:11 NOTICE: (02) : copy-file /tmp/045803co/datadir/test_filters-rufozoq5/filtersfile.flt /tmp/045803co/workdir/ 2026/02/21 05:00:11 DEBUG : copyFile "/tmp/045803co/datadir/test_filters-rufozoq5/filtersfile.flt" to "/tmp/045803co/workdir/" as "" 2026/02/21 05:00:11 DEBUG : Creating backend with remote "/tmp/045803co/datadir/test_filters-rufozoq5/filtersfile.flt" 2026/02/21 05:00:11 DEBUG : Creating backend with remote "/tmp/045803co/workdir/" 2026/02/21 05:00:11 DEBUG : operations.CopyFile "filtersfile.flt" to "Local file system at /tmp/045803co/workdir" as "filtersfile.flt" 2026/02/21 05:00:11 DEBUG : filtersfile.flt: Need to transfer - File not found at Destination 2026/02/21 05:00:11 DEBUG : filtersfile.flt.e46c0e4d.partial: size = 254 OK 2026/02/21 05:00:11 DEBUG : filtersfile.flt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK 2026/02/21 05:00:11 DEBUG : filtersfile.flt.e46c0e4d.partial: renamed to: filtersfile.flt 2026/02/21 05:00:11 INFO : filtersfile.flt: Copied (new) 2026/02/21 05:00:11 NOTICE: (03) : test resync to force building of the filters md5 hash 2026/02/21 05:00:11 NOTICE: (04) : bisync filters-file=/tmp/045803co/workdir/filtersfile.flt resync bisync_test.go:1015: skipping test as at least one remote does not support setting modtime === RUN TestBisyncRemoteRemote/max_delete_path1 2026/02/21 05:00:11 INFO : path1: Making directory 2026/02/21 05:00:11 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/max_delete_path1/path1" 2026/02/21 05:00:11 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 05:00:12 INFO : path2: Making directory 2026/02/21 05:00:12 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/max_delete_path1/path2" 2026/02/21 05:00:12 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 05:00:13 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path1/initial" 2026/02/21 05:00:13 DEBUG : Creating backend with remote "/tmp/045803co/initdir/test_max_delete_path1-yuxayaw6" 2026/02/21 05:00:13 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:13 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:13 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:13 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:13 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:13 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:13 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:13 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:13 DEBUG : file9.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:13 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 05:00:13 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:13 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 05:00:13 INFO : file1.txt: Copied (new) 2026/02/21 05:00:13 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 05:00:13 DEBUG : Local file system at /tmp/045803co/initdir/test_max_delete_path1-yuxayaw6: Waiting for checks to finish 2026/02/21 05:00:13 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2026/02/21 05:00:13 DEBUG : Local file system at /tmp/045803co/initdir/test_max_delete_path1-yuxayaw6: Waiting for transfers to finish 2026/02/21 05:00:13 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:13 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2026/02/21 05:00:13 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 05:00:13 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:13 INFO : file2.txt: Copied (new) 2026/02/21 05:00:13 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2026/02/21 05:00:13 INFO : file3.txt: Copied (new) 2026/02/21 05:00:13 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2026/02/21 05:00:13 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:13 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2026/02/21 05:00:13 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:13 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2026/02/21 05:00:13 INFO : file5.txt: Copied (new) 2026/02/21 05:00:13 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2026/02/21 05:00:13 INFO : file6.txt: Copied (new) 2026/02/21 05:00:13 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:13 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2026/02/21 05:00:13 INFO : file4.txt: Copied (new) 2026/02/21 05:00:13 DEBUG : file8.txt.b300b322.partial: size = 0 OK 2026/02/21 05:00:13 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:13 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt 2026/02/21 05:00:13 INFO : file8.txt: Copied (new) 2026/02/21 05:00:13 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2026/02/21 05:00:13 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:13 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2026/02/21 05:00:13 INFO : file7.txt: Copied (new) 2026/02/21 05:00:13 DEBUG : file9.txt.84a50ab9.partial: size = 109 OK 2026/02/21 05:00:13 DEBUG : file9.txt: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 05:00:13 DEBUG : file9.txt.84a50ab9.partial: renamed to: file9.txt 2026/02/21 05:00:13 INFO : file9.txt: Copied (new) 2026/02/21 05:00:13 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_max_delete_path1/modfiles" 2026/02/21 05:00:13 DEBUG : Creating backend with remote "/tmp/045803co/datadir/test_max_delete_path1-lukimit3" 2026/02/21 05:00:13 DEBUG : hold.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:13 DEBUG : Local file system at /tmp/045803co/datadir/test_max_delete_path1-lukimit3: Waiting for checks to finish 2026/02/21 05:00:13 DEBUG : Local file system at /tmp/045803co/datadir/test_max_delete_path1-lukimit3: Waiting for transfers to finish 2026/02/21 05:00:13 DEBUG : hold.txt.83686dab.partial: size = 59 OK 2026/02/21 05:00:13 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2026/02/21 05:00:13 DEBUG : hold.txt.83686dab.partial: renamed to: hold.txt 2026/02/21 05:00:13 INFO : hold.txt: Copied (new) 2026/02/21 05:00:13 DEBUG : Waiting for deletions to finish 2026/02/21 05:00:13 ERROR : error listing: directory not found 2026/02/21 05:00:13 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path1/path1': Failed to list "": directory not found 2026/02/21 05:00:13 DEBUG : removing 1 level 0 directories 2026/02/21 05:00:13 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path1/path1': Removing directory 2026/02/21 05:00:13 ERROR : Failed to rmdir: directory not found 2026/02/21 05:00:13 DEBUG : Waiting for deletions to finish 2026/02/21 05:00:13 ERROR : error listing: directory not found 2026/02/21 05:00:13 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path1/path2': Failed to list "": directory not found 2026/02/21 05:00:13 DEBUG : removing 1 level 0 directories 2026/02/21 05:00:13 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path1/path2': Removing directory 2026/02/21 05:00:13 ERROR : Failed to rmdir: directory not found 2026/02/21 05:00:14 ERROR : error listing: directory not found 2026/02/21 05:00:14 ERROR : error listing: directory not found 2026/02/21 05:00:14 NOTICE: checking initFs Local file system at /tmp/045803co/initdir/test_max_delete_path1-yuxayaw6 2026/02/21 05:00:14 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:14 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:14 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:14 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:14 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:14 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:14 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:14 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:14 DEBUG : file9.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:14 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path1/path1': Waiting for checks to finish 2026/02/21 05:00:14 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path1/path1': Waiting for transfers to finish 2026/02/21 05:00:14 DEBUG : file1.txt: size = 0 OK 2026/02/21 05:00:14 INFO : file1.txt: Copied (new) 2026/02/21 05:00:15 DEBUG : file2.txt: size = 0 OK 2026/02/21 05:00:15 INFO : file2.txt: Copied (new) 2026/02/21 05:00:15 DEBUG : file4.txt: size = 0 OK 2026/02/21 05:00:15 INFO : file4.txt: Copied (new) 2026/02/21 05:00:15 DEBUG : file3.txt: size = 0 OK 2026/02/21 05:00:15 INFO : file3.txt: Copied (new) 2026/02/21 05:00:15 DEBUG : file5.txt: size = 0 OK 2026/02/21 05:00:15 INFO : file5.txt: Copied (new) 2026/02/21 05:00:15 DEBUG : file8.txt: size = 0 OK 2026/02/21 05:00:15 INFO : file8.txt: Copied (new) 2026/02/21 05:00:15 DEBUG : file6.txt: size = 0 OK 2026/02/21 05:00:15 INFO : file6.txt: Copied (new) 2026/02/21 05:00:15 DEBUG : file7.txt: size = 0 OK 2026/02/21 05:00:15 INFO : file7.txt: Copied (new) 2026/02/21 05:00:16 DEBUG : file9.txt: size = 109 OK 2026/02/21 05:00:16 INFO : file9.txt: Copied (new) 2026/02/21 05:00:16 NOTICE: checking Path1 Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path1/path1' fstest.go:298: Sleeping for 1s for list eventual consistency: 1/5 fstest.go:292: Sleeping for 6s just to make sure 2026/02/21 05:00:23 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:23 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:23 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:23 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:23 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:23 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:23 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:23 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:23 DEBUG : file9.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:23 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path1/path2': Waiting for checks to finish 2026/02/21 05:00:23 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path1/path2': Waiting for transfers to finish 2026/02/21 05:00:24 DEBUG : file1.txt: size = 0 OK 2026/02/21 05:00:24 INFO : file1.txt: Copied (new) 2026/02/21 05:00:24 DEBUG : file3.txt: size = 0 OK 2026/02/21 05:00:24 INFO : file3.txt: Copied (new) 2026/02/21 05:00:24 DEBUG : file4.txt: size = 0 OK 2026/02/21 05:00:24 INFO : file4.txt: Copied (new) 2026/02/21 05:00:24 DEBUG : file2.txt: size = 0 OK 2026/02/21 05:00:24 INFO : file2.txt: Copied (new) 2026/02/21 05:00:24 DEBUG : file5.txt: size = 0 OK 2026/02/21 05:00:24 INFO : file5.txt: Copied (new) 2026/02/21 05:00:24 DEBUG : file6.txt: size = 0 OK 2026/02/21 05:00:24 INFO : file6.txt: Copied (new) 2026/02/21 05:00:24 DEBUG : file7.txt: size = 0 OK 2026/02/21 05:00:24 INFO : file7.txt: Copied (new) 2026/02/21 05:00:24 DEBUG : file8.txt: size = 0 OK 2026/02/21 05:00:24 INFO : file8.txt: Copied (new) 2026/02/21 05:00:25 DEBUG : file9.txt: size = 109 OK 2026/02/21 05:00:25 INFO : file9.txt: Copied (new) 2026/02/21 05:00:25 NOTICE: checking path2 Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path1/path2' 2026/02/21 05:00:25 NOTICE: (01) : test max-delete-path1 2026/02/21 05:00:25 NOTICE: (02) : test initial bisync 2026/02/21 05:00:25 NOTICE: (03) : bisync resync bisync_test.go:1015: skipping test as at least one remote does not support setting modtime === RUN TestBisyncRemoteRemote/max_delete_path2_force 2026/02/21 05:00:25 INFO : path1: Making directory 2026/02/21 05:00:25 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path1" 2026/02/21 05:00:25 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 05:00:26 INFO : path2: Making directory 2026/02/21 05:00:26 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path2" 2026/02/21 05:00:26 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 05:00:27 DEBUG : Creating backend with remote "/tmp/045803co/initdir/test_max_delete_path2_force-muvaxic3" 2026/02/21 05:00:27 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:27 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:27 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:27 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:27 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:27 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:27 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:27 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:27 DEBUG : file9.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:27 DEBUG : Local file system at /tmp/045803co/initdir/test_max_delete_path2_force-muvaxic3: Waiting for checks to finish 2026/02/21 05:00:27 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 05:00:27 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 05:00:27 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2026/02/21 05:00:27 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2026/02/21 05:00:27 DEBUG : Local file system at /tmp/045803co/initdir/test_max_delete_path2_force-muvaxic3: Waiting for transfers to finish 2026/02/21 05:00:27 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:27 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 05:00:27 INFO : file1.txt: Copied (new) 2026/02/21 05:00:27 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:27 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 05:00:27 INFO : file2.txt: Copied (new) 2026/02/21 05:00:27 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:27 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2026/02/21 05:00:27 INFO : file4.txt: Copied (new) 2026/02/21 05:00:27 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2026/02/21 05:00:27 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:27 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2026/02/21 05:00:27 INFO : file3.txt: Copied (new) 2026/02/21 05:00:27 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2026/02/21 05:00:27 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:27 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2026/02/21 05:00:27 INFO : file6.txt: Copied (new) 2026/02/21 05:00:27 DEBUG : file8.txt.b300b322.partial: size = 0 OK 2026/02/21 05:00:27 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2026/02/21 05:00:27 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:27 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:27 DEBUG : file8.txt.b300b322.partial: renamed to: file8.txt 2026/02/21 05:00:27 INFO : file8.txt: Copied (new) 2026/02/21 05:00:27 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:00:27 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2026/02/21 05:00:27 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2026/02/21 05:00:27 INFO : file5.txt: Copied (new) 2026/02/21 05:00:27 INFO : file7.txt: Copied (new) 2026/02/21 05:00:27 DEBUG : file9.txt.84a50ab9.partial: size = 109 OK 2026/02/21 05:00:27 DEBUG : file9.txt: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 05:00:27 DEBUG : file9.txt.84a50ab9.partial: renamed to: file9.txt 2026/02/21 05:00:27 INFO : file9.txt: Copied (new) 2026/02/21 05:00:27 DEBUG : Creating backend with remote "/tmp/045803co/datadir/test_max_delete_path2_force-fakutab7" 2026/02/21 05:00:27 DEBUG : hold.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:27 DEBUG : Local file system at /tmp/045803co/datadir/test_max_delete_path2_force-fakutab7: Waiting for checks to finish 2026/02/21 05:00:27 DEBUG : Local file system at /tmp/045803co/datadir/test_max_delete_path2_force-fakutab7: Waiting for transfers to finish 2026/02/21 05:00:27 DEBUG : hold.txt.83686dab.partial: size = 59 OK 2026/02/21 05:00:27 DEBUG : hold.txt: md5 = 628c2241b6ba4e313ef08bdfcf1cd964 OK 2026/02/21 05:00:27 DEBUG : hold.txt.83686dab.partial: renamed to: hold.txt 2026/02/21 05:00:27 INFO : hold.txt: Copied (new) 2026/02/21 05:00:27 DEBUG : Waiting for deletions to finish 2026/02/21 05:00:27 ERROR : error listing: directory not found 2026/02/21 05:00:28 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path1': Failed to list "": directory not found 2026/02/21 05:00:28 DEBUG : removing 1 level 0 directories 2026/02/21 05:00:28 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path1': Removing directory 2026/02/21 05:00:28 ERROR : Failed to rmdir: directory not found 2026/02/21 05:00:28 DEBUG : Waiting for deletions to finish 2026/02/21 05:00:28 ERROR : error listing: directory not found 2026/02/21 05:00:28 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path2': Failed to list "": directory not found 2026/02/21 05:00:28 DEBUG : removing 1 level 0 directories 2026/02/21 05:00:28 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path2': Removing directory 2026/02/21 05:00:28 ERROR : Failed to rmdir: directory not found 2026/02/21 05:00:29 ERROR : error listing: directory not found 2026/02/21 05:00:29 ERROR : error listing: directory not found 2026/02/21 05:00:29 NOTICE: checking initFs Local file system at /tmp/045803co/initdir/test_max_delete_path2_force-muvaxic3 2026/02/21 05:00:29 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:29 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:29 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:29 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:29 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:29 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:29 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:29 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:29 DEBUG : file9.txt: Need to transfer - File not found at Destination 2026/02/21 05:00:29 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path1': Waiting for checks to finish 2026/02/21 05:00:29 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path1': Waiting for transfers to finish 2026/02/21 05:00:30 ERROR : file1.txt: Failed to copy: failed to create empty file metadata: create meta: Folder not found (status 404) 2026/02/21 05:00:30 DEBUG : file2.txt: size = 0 OK 2026/02/21 05:00:30 INFO : file2.txt: Copied (new) 2026/02/21 05:00:30 DEBUG : file4.txt: size = 0 OK 2026/02/21 05:00:30 INFO : file4.txt: Copied (new) 2026/02/21 05:00:30 DEBUG : file3.txt: size = 0 OK 2026/02/21 05:00:30 INFO : file3.txt: Copied (new) 2026/02/21 05:00:30 DEBUG : file5.txt: size = 0 OK 2026/02/21 05:00:30 INFO : file5.txt: Copied (new) 2026/02/21 05:00:30 DEBUG : file7.txt: size = 0 OK 2026/02/21 05:00:30 INFO : file7.txt: Copied (new) 2026/02/21 05:00:30 DEBUG : file6.txt: size = 0 OK 2026/02/21 05:00:30 INFO : file6.txt: Copied (new) 2026/02/21 05:00:30 DEBUG : file8.txt: size = 0 OK 2026/02/21 05:00:30 INFO : file8.txt: Copied (new) 2026/02/21 05:00:31 DEBUG : file9.txt: size = 109 OK 2026/02/21 05:00:31 INFO : file9.txt: Copied (new) bisync_test.go:2013: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:2013 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:506 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Received unexpected error: failed to create empty file metadata: create meta: Folder not found (status 404) Test: TestBisyncRemoteRemote/max_delete_path2_force Messages: setting up path1 2026/02/21 05:00:31 NOTICE: checking Path1 Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path1' fstest.go:298: Sleeping for 1s for list eventual consistency: 1/5 fstest.go:298: Sleeping for 2s for list eventual consistency: 2/5 fstest.go:298: Sleeping for 4s for list eventual consistency: 3/5 fstest.go:298: Sleeping for 8s for list eventual consistency: 4/5 fstest.go:298: Sleeping for 16s for list eventual consistency: 5/5 fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:508 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Should be true Test: TestBisyncRemoteRemote/max_delete_path2_force Messages: listing wrong, want file1.txt (0), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0), file9.txt (109) got file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0), file9.txt (109) fstest.go:203: Not found "file1.txt" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:508 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Not equal: expected: 0 actual : 1 Test: TestBisyncRemoteRemote/max_delete_path2_force Messages: 1 objects not found 2026/02/21 05:01:04 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:04 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:04 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:04 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:04 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:04 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:04 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:04 DEBUG : file8.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:04 DEBUG : file9.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:04 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path2': Waiting for checks to finish 2026/02/21 05:01:04 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path2': Waiting for transfers to finish 2026/02/21 05:01:05 ERROR : file1.txt: Failed to copy: failed to create empty file metadata: create meta: Folder not found (status 404) 2026/02/21 05:01:05 DEBUG : file4.txt: size = 0 OK 2026/02/21 05:01:05 INFO : file4.txt: Copied (new) 2026/02/21 05:01:05 DEBUG : file2.txt: size = 0 OK 2026/02/21 05:01:05 INFO : file2.txt: Copied (new) 2026/02/21 05:01:05 DEBUG : file3.txt: size = 0 OK 2026/02/21 05:01:05 INFO : file3.txt: Copied (new) 2026/02/21 05:01:05 DEBUG : file5.txt: size = 0 OK 2026/02/21 05:01:05 INFO : file5.txt: Copied (new) 2026/02/21 05:01:05 DEBUG : file6.txt: size = 0 OK 2026/02/21 05:01:05 INFO : file6.txt: Copied (new) 2026/02/21 05:01:05 DEBUG : file7.txt: size = 0 OK 2026/02/21 05:01:05 INFO : file7.txt: Copied (new) 2026/02/21 05:01:06 DEBUG : file8.txt: size = 0 OK 2026/02/21 05:01:06 INFO : file8.txt: Copied (new) 2026/02/21 05:01:06 DEBUG : file9.txt: size = 109 OK 2026/02/21 05:01:06 INFO : file9.txt: Copied (new) bisync_test.go:2013: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:2013 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:509 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Received unexpected error: failed to create empty file metadata: create meta: Folder not found (status 404) Test: TestBisyncRemoteRemote/max_delete_path2_force Messages: setting up path2 2026/02/21 05:01:06 NOTICE: checking path2 Internxt root 'rclone-test-cucoyut6qixi/045803co/max_delete_path2_force/path2' fstest.go:298: Sleeping for 1s for list eventual consistency: 1/5 fstest.go:298: Sleeping for 2s for list eventual consistency: 2/5 fstest.go:298: Sleeping for 4s for list eventual consistency: 3/5 fstest.go:298: Sleeping for 8s for list eventual consistency: 4/5 fstest.go:298: Sleeping for 16s for list eventual consistency: 5/5 fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:511 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Should be true Test: TestBisyncRemoteRemote/max_delete_path2_force Messages: listing wrong, want file1.txt (0), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0), file9.txt (109) got file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0), file9.txt (109) fstest.go:203: Not found "file1.txt" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:511 /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 Error: Not equal: expected: 0 actual : 1 Test: TestBisyncRemoteRemote/max_delete_path2_force Messages: 1 objects not found 2026/02/21 05:01:38 NOTICE: (01) : test max-delete-path2-force 2026/02/21 05:01:38 NOTICE: (02) : test initial bisync 2026/02/21 05:01:38 NOTICE: (03) : bisync resync bisync_test.go:1015: skipping test as at least one remote does not support setting modtime === RUN TestBisyncRemoteRemote/resync 2026/02/21 05:01:38 INFO : path1: Making directory 2026/02/21 05:01:38 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/resync/path1" 2026/02/21 05:01:38 DEBUG : Config file has changed externally - reloading 2026/02/21 05:01:39 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 05:01:40 INFO : path2: Making directory 2026/02/21 05:01:40 DEBUG : Creating backend with remote "TestInternxt:rclone-test-cucoyut6qixi/045803co/resync/path2" 2026/02/21 05:01:40 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/02/21 05:01:41 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/initial" 2026/02/21 05:01:41 DEBUG : Creating backend with remote "/tmp/045803co/initdir/test_resync-hupusuv9" 2026/02/21 05:01:41 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 05:01:41 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:41 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:41 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:41 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:41 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:41 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:41 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:41 DEBUG : Local file system at /tmp/045803co/initdir/test_resync-hupusuv9: Waiting for checks to finish 2026/02/21 05:01:41 DEBUG : Local file system at /tmp/045803co/initdir/test_resync-hupusuv9: Waiting for transfers to finish 2026/02/21 05:01:41 DEBUG : file1.txt.56d0d699.partial: size = 0 OK 2026/02/21 05:01:41 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:01:41 DEBUG : file2.txt.3230ad67.partial: size = 0 OK 2026/02/21 05:01:41 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt 2026/02/21 05:01:41 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:01:41 INFO : file1.txt: Copied (new) 2026/02/21 05:01:41 DEBUG : file3.txt.a74079f2.partial: size = 0 OK 2026/02/21 05:01:41 DEBUG : file2.txt.3230ad67.partial: renamed to: file2.txt 2026/02/21 05:01:41 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:01:41 INFO : file2.txt: Copied (new) 2026/02/21 05:01:41 DEBUG : file3.txt.a74079f2.partial: renamed to: file3.txt 2026/02/21 05:01:41 INFO : file3.txt: Copied (new) 2026/02/21 05:01:41 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK 2026/02/21 05:01:41 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2026/02/21 05:01:41 DEBUG : file6.txt.0a60f5f0.partial: size = 0 OK 2026/02/21 05:01:41 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:01:41 DEBUG : file4.txt.fbf05a9b.partial: size = 0 OK 2026/02/21 05:01:41 DEBUG : file5.txt.6e808e0e.partial: size = 0 OK 2026/02/21 05:01:41 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:01:41 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:01:41 DEBUG : file6.txt.0a60f5f0.partial: renamed to: file6.txt 2026/02/21 05:01:41 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST 2026/02/21 05:01:41 INFO : file6.txt: Copied (new) 2026/02/21 05:01:41 INFO : RCLONE_TEST: Copied (new) 2026/02/21 05:01:41 DEBUG : file4.txt.fbf05a9b.partial: renamed to: file4.txt 2026/02/21 05:01:41 INFO : file4.txt: Copied (new) 2026/02/21 05:01:41 DEBUG : file5.txt.6e808e0e.partial: renamed to: file5.txt 2026/02/21 05:01:41 INFO : file5.txt: Copied (new) 2026/02/21 05:01:41 DEBUG : file7.txt.9f102165.partial: size = 0 OK 2026/02/21 05:01:41 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/02/21 05:01:41 DEBUG : file7.txt.9f102165.partial: renamed to: file7.txt 2026/02/21 05:01:41 INFO : file7.txt: Copied (new) 2026/02/21 05:01:41 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync/modfiles" 2026/02/21 05:01:41 DEBUG : Creating backend with remote "/tmp/045803co/datadir/test_resync-ziqepuy4" 2026/02/21 05:01:41 DEBUG : fileA.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:41 DEBUG : fileB.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:41 DEBUG : Local file system at /tmp/045803co/datadir/test_resync-ziqepuy4: Waiting for checks to finish 2026/02/21 05:01:41 DEBUG : Local file system at /tmp/045803co/datadir/test_resync-ziqepuy4: Waiting for transfers to finish 2026/02/21 05:01:41 DEBUG : fileA.txt.04c13af3.partial: size = 19 OK 2026/02/21 05:01:41 DEBUG : fileB.txt.b8ec97e6.partial: size = 19 OK 2026/02/21 05:01:41 DEBUG : fileA.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 05:01:41 DEBUG : fileB.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK 2026/02/21 05:01:41 DEBUG : fileA.txt.04c13af3.partial: renamed to: fileA.txt 2026/02/21 05:01:41 INFO : fileA.txt: Copied (new) 2026/02/21 05:01:41 DEBUG : fileB.txt.b8ec97e6.partial: renamed to: fileB.txt 2026/02/21 05:01:41 INFO : fileB.txt: Copied (new) 2026/02/21 05:01:41 DEBUG : Waiting for deletions to finish 2026/02/21 05:01:41 ERROR : error listing: directory not found 2026/02/21 05:01:41 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/resync/path1': Failed to list "": directory not found 2026/02/21 05:01:41 DEBUG : removing 1 level 0 directories 2026/02/21 05:01:41 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/resync/path1': Removing directory 2026/02/21 05:01:41 ERROR : Failed to rmdir: directory not found 2026/02/21 05:01:41 DEBUG : Waiting for deletions to finish 2026/02/21 05:01:41 ERROR : error listing: directory not found 2026/02/21 05:01:41 ERROR : Internxt root 'rclone-test-cucoyut6qixi/045803co/resync/path2': Failed to list "": directory not found 2026/02/21 05:01:41 DEBUG : removing 1 level 0 directories 2026/02/21 05:01:41 INFO : Internxt root 'rclone-test-cucoyut6qixi/045803co/resync/path2': Removing directory 2026/02/21 05:01:41 ERROR : Failed to rmdir: directory not found 2026/02/21 05:01:41 ERROR : error listing: directory not found 2026/02/21 05:01:41 ERROR : error listing: directory not found 2026/02/21 05:01:41 NOTICE: checking initFs Local file system at /tmp/045803co/initdir/test_resync-hupusuv9 2026/02/21 05:01:42 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 05:01:42 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:42 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:42 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:42 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:42 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:42 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:42 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:42 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/resync/path1': Waiting for checks to finish 2026/02/21 05:01:42 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/resync/path1': Waiting for transfers to finish 2026/02/21 05:01:42 DEBUG : file1.txt: size = 0 OK 2026/02/21 05:01:42 INFO : file1.txt: Copied (new) 2026/02/21 05:01:43 DEBUG : file3.txt: size = 0 OK 2026/02/21 05:01:43 INFO : file3.txt: Copied (new) 2026/02/21 05:01:43 DEBUG : file4.txt: size = 0 OK 2026/02/21 05:01:43 INFO : file4.txt: Copied (new) 2026/02/21 05:01:43 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 05:01:43 INFO : RCLONE_TEST: Copied (new) 2026/02/21 05:01:43 DEBUG : file2.txt: size = 0 OK 2026/02/21 05:01:43 INFO : file2.txt: Copied (new) 2026/02/21 05:01:43 DEBUG : file5.txt: size = 0 OK 2026/02/21 05:01:43 INFO : file5.txt: Copied (new) 2026/02/21 05:01:43 DEBUG : file6.txt: size = 0 OK 2026/02/21 05:01:43 INFO : file6.txt: Copied (new) 2026/02/21 05:01:43 DEBUG : file7.txt: size = 0 OK 2026/02/21 05:01:43 INFO : file7.txt: Copied (new) 2026/02/21 05:01:43 NOTICE: checking Path1 Internxt root 'rclone-test-cucoyut6qixi/045803co/resync/path1' 2026/02/21 05:01:44 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2026/02/21 05:01:44 DEBUG : file1.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:44 DEBUG : file2.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:44 DEBUG : file3.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:44 DEBUG : file4.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:44 DEBUG : file5.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:44 DEBUG : file6.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:44 DEBUG : file7.txt: Need to transfer - File not found at Destination 2026/02/21 05:01:44 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/resync/path2': Waiting for checks to finish 2026/02/21 05:01:44 DEBUG : Internxt root 'rclone-test-cucoyut6qixi/045803co/resync/path2': Waiting for transfers to finish 2026/02/21 05:01:45 DEBUG : file3.txt: size = 0 OK 2026/02/21 05:01:45 INFO : file3.txt: Copied (new) 2026/02/21 05:01:45 DEBUG : file1.txt: size = 0 OK 2026/02/21 05:01:45 INFO : file1.txt: Copied (new) 2026/02/21 05:01:45 DEBUG : RCLONE_TEST: size = 109 OK 2026/02/21 05:01:45 INFO : RCLONE_TEST: Copied (new) 2026/02/21 05:01:45 DEBUG : file5.txt: size = 0 OK 2026/02/21 05:01:45 INFO : file5.txt: Copied (new) 2026/02/21 05:01:45 DEBUG : file6.txt: size = 0 OK 2026/02/21 05:01:45 INFO : file6.txt: Copied (new) 2026/02/21 05:01:45 DEBUG : file7.txt: size = 0 OK 2026/02/21 05:01:45 INFO : file7.txt: Copied (new) 2026/02/21 05:01:45 DEBUG : file4.txt: size = 0 OK 2026/02/21 05:01:45 INFO : file4.txt: Copied (new) 2026/02/21 05:01:45 DEBUG : file2.txt: size = 0 OK 2026/02/21 05:01:45 INFO : file2.txt: Copied (new) 2026/02/21 05:01:45 NOTICE: checking path2 Internxt root 'rclone-test-cucoyut6qixi/045803co/resync/path2' fstest.go:298: Sleeping for 1s for list eventual consistency: 1/5 fstest.go:292: Sleeping for 6s just to make sure 2026/02/21 05:01:53 NOTICE: (01) : test resync 2026/02/21 05:01:53 NOTICE: (02) : test 1. resync with empty path1, resulting in copying all content from path2. 2026/02/21 05:01:53 NOTICE: (03) : purge-children TestInternxt:rclone-test-cucoyut6qixi/045803co/resync/path1/ 2026/02/21 05:01:53 DEBUG : file1.txt: Remove file 2026/02/21 05:01:53 DEBUG : file2.txt: Remove file 2026/02/21 05:01:53 DEBUG : file3.txt: Remove file 2026/02/21 05:01:54 DEBUG : file4.txt: Remove file 2026/02/21 05:01:54 DEBUG : file5.txt: Remove file 2026/02/21 05:01:54 DEBUG : file6.txt: Remove file 2026/02/21 05:01:54 DEBUG : file7.txt: Remove file 2026/02/21 05:01:54 DEBUG : RCLONE_TEST: Remove file 2026/02/21 05:01:55 NOTICE: (04) : bisync resync bisync_test.go:1015: skipping test as at least one remote does not support setting modtime 2026/02/21 05:01:57 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path1/RCLONE_TEST" 2026/02/21 05:01:57 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path1/file1.txt" 2026/02/21 05:01:57 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path1/file2.txt" 2026/02/21 05:01:58 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path1/file3.txt" 2026/02/21 05:01:58 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path1/file4.txt" 2026/02/21 05:01:58 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path1/file5.txt" 2026/02/21 05:01:58 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path1/file6.txt" 2026/02/21 05:01:59 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path1/file7.txt" 2026/02/21 05:01:59 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path2/RCLONE_TEST" 2026/02/21 05:01:59 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path2/file1.txt" 2026/02/21 05:01:59 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path2/file2.txt" 2026/02/21 05:01:59 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path2/file3.txt" 2026/02/21 05:02:00 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path2/file4.txt" 2026/02/21 05:02:00 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path2/file5.txt" 2026/02/21 05:02:00 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path2/file6.txt" 2026/02/21 05:02:00 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path2/file7.txt" 2026/02/21 05:02:00 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path1/file5.txt" 2026/02/21 05:02:01 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path1/file6.txt" 2026/02/21 05:02:01 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path1/file7.txt" 2026/02/21 05:02:01 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path1/file8.txt" 2026/02/21 05:02:01 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path2/RCLONE_TEST" 2026/02/21 05:02:01 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path2/file1.txt" 2026/02/21 05:02:02 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path2/file2.txt" 2026/02/21 05:02:02 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path2/file3.txt" 2026/02/21 05:02:02 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path2/file4.txt" 2026/02/21 05:02:02 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path2/file5.txt" 2026/02/21 05:02:02 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path2/file6.txt" 2026/02/21 05:02:03 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path2/file7.txt" 2026/02/21 05:02:03 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/changes/path2/file8.txt" 2026/02/21 05:02:03 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path1/RCLONE_TEST" 2026/02/21 05:02:03 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path1/file1.txt" 2026/02/21 05:02:03 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path1/file2.txt" 2026/02/21 05:02:04 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path1/file3.txt" 2026/02/21 05:02:04 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path1/file4.txt" 2026/02/21 05:02:04 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path1/file5.txt" 2026/02/21 05:02:04 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path1/file6.txt" 2026/02/21 05:02:04 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path1/file7.txt" 2026/02/21 05:02:05 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path1/file8.txt" 2026/02/21 05:02:05 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path2/RCLONE_TEST" 2026/02/21 05:02:05 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path2/file2.txt" 2026/02/21 05:02:05 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path2/file3.txt" 2026/02/21 05:02:05 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path2/file4.txt" 2026/02/21 05:02:06 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path2/file5.txt" 2026/02/21 05:02:06 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path2/file6.txt" 2026/02/21 05:02:06 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path2/file7.txt" 2026/02/21 05:02:06 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/concurrent/path2/file8.txt" 2026/02/21 05:02:06 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/equal/path1/RCLONE_TEST" 2026/02/21 05:02:07 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/equal/path1/file1.txt" 2026/02/21 05:02:07 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/equal/path1/file2.txt" 2026/02/21 05:02:07 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/equal/path2/RCLONE_TEST" 2026/02/21 05:02:07 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/equal/path2/file2.txt" 2026/02/21 05:02:07 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path1/file1.txt" 2026/02/21 05:02:08 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path1/file2.txt" 2026/02/21 05:02:08 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path1/file3.txt" 2026/02/21 05:02:08 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path1/file4.txt" 2026/02/21 05:02:08 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path1/file5.txt" 2026/02/21 05:02:08 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path1/file6.txt" 2026/02/21 05:02:09 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path1/file7.txt" 2026/02/21 05:02:09 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path1/file8.txt" 2026/02/21 05:02:09 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path1/file9.txt" 2026/02/21 05:02:09 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path2/file1.txt" 2026/02/21 05:02:09 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path2/file2.txt" 2026/02/21 05:02:09 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path2/file3.txt" 2026/02/21 05:02:10 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path2/file4.txt" 2026/02/21 05:02:10 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path2/file5.txt" 2026/02/21 05:02:10 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path2/file6.txt" 2026/02/21 05:02:10 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path2/file7.txt" 2026/02/21 05:02:10 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path2/file8.txt" 2026/02/21 05:02:11 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path1/path2/file9.txt" 2026/02/21 05:02:11 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path1/file2.txt" 2026/02/21 05:02:11 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path1/file3.txt" 2026/02/21 05:02:11 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path1/file4.txt" 2026/02/21 05:02:11 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path1/file5.txt" 2026/02/21 05:02:12 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path1/file6.txt" 2026/02/21 05:02:12 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path1/file7.txt" 2026/02/21 05:02:12 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path1/file8.txt" 2026/02/21 05:02:12 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path1/file9.txt" 2026/02/21 05:02:13 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path2/file2.txt" 2026/02/21 05:02:13 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path2/file3.txt" 2026/02/21 05:02:13 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path2/file4.txt" 2026/02/21 05:02:13 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path2/file5.txt" 2026/02/21 05:02:13 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path2/file6.txt" 2026/02/21 05:02:13 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path2/file7.txt" 2026/02/21 05:02:14 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path2/file8.txt" 2026/02/21 05:02:14 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/max_delete_path2_force/path2/file9.txt" 2026/02/21 05:02:14 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/resync/path2/RCLONE_TEST" 2026/02/21 05:02:14 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/resync/path2/file1.txt" 2026/02/21 05:02:14 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/resync/path2/file2.txt" 2026/02/21 05:02:15 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/resync/path2/file3.txt" 2026/02/21 05:02:15 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/resync/path2/file4.txt" 2026/02/21 05:02:15 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/resync/path2/file5.txt" 2026/02/21 05:02:15 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/resync/path2/file6.txt" 2026/02/21 05:02:16 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/resync/path2/file7.txt" 2026/02/21 05:02:16 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path1/subdir/file20.txt" 2026/02/21 05:02:16 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge object "045803co/filters/path2/subdir/file20.txt" 2026/02/21 05:02:16 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/resync/path2" 2026/02/21 05:02:16 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/resync/path1" 2026/02/21 05:02:17 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/resync" 2026/02/21 05:02:17 NOTICE: purge failed to rmdir "045803co/resync": directory not empty 2026/02/21 05:02:17 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/path2" 2026/02/21 05:02:17 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/path1" 2026/02/21 05:02:17 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/max_delete_path2_force/path2" 2026/02/21 05:02:18 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/max_delete_path2_force/path1" 2026/02/21 05:02:18 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/max_delete_path2_force" 2026/02/21 05:02:18 NOTICE: purge failed to rmdir "045803co/max_delete_path2_force": directory not empty 2026/02/21 05:02:18 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/max_delete_path1/path2" 2026/02/21 05:02:18 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/max_delete_path1/path1" 2026/02/21 05:02:19 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/max_delete_path1" 2026/02/21 05:02:19 NOTICE: purge failed to rmdir "045803co/max_delete_path1": directory not empty 2026/02/21 05:02:19 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/filters/path2/subdir" 2026/02/21 05:02:19 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/filters/path2" 2026/02/21 05:02:19 NOTICE: purge failed to rmdir "045803co/filters/path2": directory not empty 2026/02/21 05:02:19 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/filters/path1/subdir" 2026/02/21 05:02:20 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/filters/path1" 2026/02/21 05:02:20 NOTICE: purge failed to rmdir "045803co/filters/path1": directory not empty 2026/02/21 05:02:20 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/filters" 2026/02/21 05:02:20 NOTICE: purge failed to rmdir "045803co/filters": directory not empty 2026/02/21 05:02:20 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/equal/path2" 2026/02/21 05:02:20 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/equal/path1" 2026/02/21 05:02:20 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/equal" 2026/02/21 05:02:21 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/concurrent/path2" 2026/02/21 05:02:21 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/concurrent/path1" 2026/02/21 05:02:22 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/concurrent" 2026/02/21 05:02:22 NOTICE: purge failed to rmdir "045803co/concurrent": directory not empty 2026/02/21 05:02:22 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/changes/path2" 2026/02/21 05:02:22 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/changes/path1" 2026/02/21 05:02:22 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co/changes" 2026/02/21 05:02:22 NOTICE: purge failed to rmdir "045803co/changes": directory not empty 2026/02/21 05:02:22 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "045803co" 2026/02/21 05:02:23 NOTICE: purge failed to rmdir "045803co": directory not empty 2026/02/21 05:02:23 DEBUG : Internxt root 'rclone-test-cucoyut6qixi': Purge dir "" 2026/02/21 05:02:23 NOTICE: purge failed to rmdir "": directory not empty --- FAIL: TestBisyncRemoteRemote (259.82s) --- FAIL: TestBisyncRemoteRemote/changes (40.72s) --- FAIL: TestBisyncRemoteRemote/concurrent (39.51s) --- FAIL: TestBisyncRemoteRemote/equal (38.44s) --- SKIP: TestBisyncRemoteRemote/filters (8.72s) --- SKIP: TestBisyncRemoteRemote/max_delete_path1 (14.49s) --- FAIL: TestBisyncRemoteRemote/max_delete_path2_force (73.08s) --- SKIP: TestBisyncRemoteRemote/resync (16.38s) FAIL 2026/02/21 05:02:23 ERROR : error listing: directory not found 2026/02/21 05:02:23 DEBUG : Internxt root 'rclone-test-wobunir1duxe': Purge dir "" 2026/02/21 05:02:23 NOTICE: purge failed to rmdir "": directory not found 2026/02/21 05:02:23 NOTICE: purge failed: directory not found "./bisync.test -test.v -test.timeout 1h0m0s -remote TestInternxt: -list-retries 5 -verbose -test.run '^TestBisyncLocalRemote$/^(all_changed|max_delete_path2_force|normalization)$|^TestBisyncRemoteLocal$/^rclone_args$|^TestBisyncRemoteRemote$/^(changes|concurrent|equal|filters|max_delete_path1|max_delete_path2_force|resync)$'" - Finished ERROR in 5m31.158614462s (try 4/5): exit status 1: Failed [TestBisyncLocalRemote/normalization TestBisyncRemoteRemote/changes TestBisyncRemoteRemote/concurrent TestBisyncRemoteRemote/equal TestBisyncRemoteRemote/max_delete_path2_force]