"./bisync.test -test.v -test.timeout 1h0m0s -remote TestSMBKerberos:rclone -verbose -test.run '^TestBisyncLocalRemote$/^compare_all$|^TestBisyncRemoteRemote$/^(check_access_filters|ext_paths|normalization|resync_modes)$'" - Starting (try 4/5)
2025/07/07 03:17:41 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-digaxaf0zuni"
2025/07/07 03:17:41 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/07/07 03:17:41 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:41 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:41 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:41 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:41 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:41 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:41 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:41 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:41 DEBUG : Creating backend with remote "/tmp/rclone2516613077"
=== RUN   TestBisyncLocalRemote
2025/07/07 03:17:41 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-saliluy2duhu"
2025/07/07 03:17:41 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:41 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:41 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:41 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:41 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:41 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:41 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:41 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:41 NOTICE: remote: TestSMBKerberos:rclone/rclone-test-saliluy2duhu
=== RUN   TestBisyncLocalRemote/compare_all
2025/07/07 03:17:41 DEBUG : Creating backend with remote "/tmp/031741ya"
2025/07/07 03:17:41 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/07/07 03:17:41 DEBUG : Creating backend with remote "/tmp/031741ya/compare_all/path1"
2025/07/07 03:17:41 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-saliluy2duhu/031741ya"
2025/07/07 03:17:41 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:41 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:41 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:41 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:41 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:41 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:41 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:41 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:41 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-saliluy2duhu/031741ya" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya"
2025/07/07 03:17:41 INFO  : path2: Making directory
2025/07/07 03:17:41 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2"
2025/07/07 03:17:41 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:41 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:41 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:41 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:41 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:41 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:41 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:41 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:41 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2"
2025/07/07 03:17:41 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_compare_all/initial"
2025/07/07 03:17:41 DEBUG : Creating backend with remote "/tmp/031741ya/initdir/test_compare_all-qoxuwuw1"
2025/07/07 03:17:41 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:41 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : Local file system at /tmp/031741ya/initdir/test_compare_all-qoxuwuw1: Waiting for checks to finish
2025/07/07 03:17:41 DEBUG : Local file system at /tmp/031741ya/initdir/test_compare_all-qoxuwuw1: Waiting for transfers to finish
2025/07/07 03:17:41 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:41 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:41 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt
2025/07/07 03:17:41 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/07/07 03:17:41 INFO  : file3.txt: Copied (new)
2025/07/07 03:17:41 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt
2025/07/07 03:17:41 INFO  : file4.txt: Copied (new)
2025/07/07 03:17:41 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:41 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt
2025/07/07 03:17:41 INFO  : file6.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt
2025/07/07 03:17:41 INFO  : file7.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt
2025/07/07 03:17:41 INFO  : file5.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file8.txt.5028a97.partial: renamed to: file8.txt
2025/07/07 03:17:41 INFO  : file8.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_compare_all/modfiles"
2025/07/07 03:17:41 DEBUG : Creating backend with remote "/tmp/031741ya/datadir/test_compare_all-kefiyud5"
2025/07/07 03:17:41 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file10.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file11.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file5L.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file5R.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : Local file system at /tmp/031741ya/datadir/test_compare_all-kefiyud5: Waiting for checks to finish
2025/07/07 03:17:41 DEBUG : Local file system at /tmp/031741ya/datadir/test_compare_all-kefiyud5: Waiting for transfers to finish
2025/07/07 03:17:41 DEBUG : file10.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/07/07 03:17:41 DEBUG : file10.txt.925c801f.partial: renamed to: file10.txt
2025/07/07 03:17:41 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/07/07 03:17:41 INFO  : file10.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file11.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/07/07 03:17:41 DEBUG : file1.txt.925c801f.partial: renamed to: file1.txt
2025/07/07 03:17:41 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file11.txt.925c801f.partial: renamed to: file11.txt
2025/07/07 03:17:41 INFO  : file11.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file2.txt: md5 = fb3ecfb2800400fb01b0bfd39903e9fb OK
2025/07/07 03:17:41 DEBUG : file5L.txt: md5 = 0860a03592626642f8fd6c8bfb447d2a OK
2025/07/07 03:17:41 DEBUG : file2.txt.f8ac1735.partial: renamed to: file2.txt
2025/07/07 03:17:41 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file5L.txt.c32cc336.partial: renamed to: file5L.txt
2025/07/07 03:17:41 INFO  : file5L.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file6.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/07/07 03:17:41 DEBUG : file6.txt.925c801f.partial: renamed to: file6.txt
2025/07/07 03:17:41 INFO  : file6.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file5R.txt: md5 = 979a803b15d27df0c31ad7d29006d10b OK
2025/07/07 03:17:41 DEBUG : file5R.txt.aa998d0a.partial: renamed to: file5R.txt
2025/07/07 03:17:41 INFO  : file5R.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file7.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/07/07 03:17:41 DEBUG : file7.txt.925c801f.partial: renamed to: file7.txt
2025/07/07 03:17:41 INFO  : file7.txt: Copied (new)
2025/07/07 03:17:41 ERROR : error listing: directory not found
2025/07/07 03:17:41 ERROR : error listing: directory not found
2025/07/07 03:17:41 NOTICE: checking initFs Local file system at /tmp/031741ya/initdir/test_compare_all-qoxuwuw1
2025/07/07 03:17:41 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/07/07 03:17:41 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:41 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt
2025/07/07 03:17:41 INFO  : file3.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt
2025/07/07 03:17:41 INFO  : file4.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file6.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt
2025/07/07 03:17:41 INFO  : file6.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt
2025/07/07 03:17:41 INFO  : file5.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file7.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : Local file system at /tmp/031741ya/compare_all/path1: Waiting for checks to finish
2025/07/07 03:17:41 DEBUG : Local file system at /tmp/031741ya/compare_all/path1: Waiting for transfers to finish
2025/07/07 03:17:41 DEBUG : file8.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:41 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:41 DEBUG : file8.txt.5028a97.partial: renamed to: file8.txt
2025/07/07 03:17:41 INFO  : file8.txt: Copied (new)
2025/07/07 03:17:41 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt
2025/07/07 03:17:41 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:41 INFO  : file7.txt: Copied (new)
2025/07/07 03:17:41 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:41 NOTICE: checking Path1 Local file system at /tmp/031741ya/compare_all/path1
2025/07/07 03:17:41 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file5.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file6.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file7.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : file8.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:41 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2: Waiting for checks to finish
2025/07/07 03:17:41 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2: Waiting for transfers to finish
2025/07/07 03:17:42 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:42 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:42 DEBUG : file5.txt.5028a97.partial: renamed to: file5.txt
2025/07/07 03:17:42 INFO  : file5.txt: Copied (new)
2025/07/07 03:17:42 DEBUG : file6.txt.5028a97.partial: renamed to: file6.txt
2025/07/07 03:17:42 INFO  : file6.txt: Copied (new)
2025/07/07 03:17:42 DEBUG : file7.txt.5028a97.partial: renamed to: file7.txt
2025/07/07 03:17:42 INFO  : file7.txt: Copied (new)
2025/07/07 03:17:42 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/07/07 03:17:42 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:42 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt
2025/07/07 03:17:42 INFO  : file3.txt: Copied (new)
2025/07/07 03:17:42 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt
2025/07/07 03:17:42 INFO  : file4.txt: Copied (new)
2025/07/07 03:17:42 DEBUG : file8.txt.5028a97.partial: renamed to: file8.txt
2025/07/07 03:17:42 INFO  : file8.txt: Copied (new)
2025/07/07 03:17:42 DEBUG : RCLONE_TEST.cf9a93ac.partial: removed after failed upload: write rclone-test-saliluy2duhu\031741ya\compare_all\path2\RCLONE_TEST.cf9a93ac.partial: invalid response error: signing required
2025/07/07 03:17:42 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2: Connection OK after error: Update ReadFrom failed: write rclone-test-saliluy2duhu\031741ya\compare_all\path2\RCLONE_TEST.cf9a93ac.partial: invalid response error: signing required
2025/07/07 03:17:42 ERROR : RCLONE_TEST: Failed to copy: Update ReadFrom failed: write rclone-test-saliluy2duhu\031741ya\compare_all\path2\RCLONE_TEST.cf9a93ac.partial: invalid response error: signing required
    bisync_test.go:1943: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1943
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:461
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Received unexpected error:
        	            	Update ReadFrom failed: write rclone-test-saliluy2duhu\031741ya\compare_all\path2\RCLONE_TEST.cf9a93ac.partial: invalid response error: signing required
        	Test:       	TestBisyncLocalRemote/compare_all
        	Messages:   	setting up path2
2025/07/07 03:17:42 NOTICE: checking path2 smb://rclone@localhost:28633/rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2
    fstest.go:295: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:295: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:302: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:335
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:463
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Should be true
        	Test:       	TestBisyncLocalRemote/compare_all
        	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
        	            	  file1.txt (0), file2.txt (0), file3.txt (0), file4.txt (0), file5.txt (0), file6.txt (0), file7.txt (0), file8.txt (0)
    fstest.go:200: Not found "RCLONE_TEST"
    fstest.go:203: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:203
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:307
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:335
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:463
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Not equal: 
        	            	expected: 0
        	            	actual  : 1
        	Test:       	TestBisyncLocalRemote/compare_all
        	Messages:   	1 objects not found
2025/07/07 03:17:49 NOTICE: (01)  : test changes compare-all
2025/07/07 03:17:49 NOTICE: (02)  : test initial bisync
2025/07/07 03:17:49 NOTICE: (03)  : bisync resync compare-all
2025/07/07 03:17:49 NOTICE: Local file system at /tmp/031741ya/compare_all/path1: will use md5 for same-side diffs on Path1 only
2025/07/07 03:17:49 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": true,
	"HashType1": 1,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": true
}
2025/07/07 03:17:49 INFO  : Synching Path1 "/tmp/031741ya/compare_all/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/"
2025/07/07 03:17:49 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:49 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:49 INFO  : TestSMBKerberos{05jGr}: Downloading hashes...
2025/07/07 03:17:49 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:49 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:49 INFO  : Resync updating listings
2025/07/07 03:17:49 INFO  : Validating listings for Path1 "/tmp/031741ya/compare_all/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/"
2025/07/07 03:17:49 INFO  : Bisync successful
2025/07/07 03:17:49 NOTICE: (04)  : test make modifications on both paths
2025/07/07 03:17:49 NOTICE: (05)  : test new on path2 - file10
2025/07/07 03:17:49 NOTICE: (06)  : touch-copy 2001-01-02 /tmp/031741ya/datadir/test_compare_all-kefiyud5/file10.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/
2025/07/07 03:17:49 INFO  : file10.txt: Copied (new)
2025/07/07 03:17:49 NOTICE: (07)  : test newer on path2 - file1
2025/07/07 03:17:49 NOTICE: (08)  : touch-copy 2001-01-02 /tmp/031741ya/datadir/test_compare_all-kefiyud5/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/
2025/07/07 03:17:49 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:49 NOTICE: (09)  : test new on path1 - file11
2025/07/07 03:17:49 NOTICE: (10)  : touch-copy 2001-01-02 /tmp/031741ya/datadir/test_compare_all-kefiyud5/file11.txt /tmp/031741ya/compare_all/path1/
2025/07/07 03:17:49 INFO  : file11.txt: Copied (new)
2025/07/07 03:17:49 NOTICE: (11)  : test newer on path1 - file2
2025/07/07 03:17:49 NOTICE: (12)  : touch-copy 2001-01-02 /tmp/031741ya/datadir/test_compare_all-kefiyud5/file2.txt /tmp/031741ya/compare_all/path1/
2025/07/07 03:17:49 INFO  : file2.txt: Copied (replaced existing)
2025/07/07 03:17:49 NOTICE: (13)  : test deleted on path2 - file3
2025/07/07 03:17:49 NOTICE: (14)  : delete-file TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/file3.txt
2025/07/07 03:17:49 INFO  : file3.txt: Deleted
2025/07/07 03:17:49 NOTICE: (15)  : test deleted on path1 - file4
2025/07/07 03:17:49 NOTICE: (16)  : delete-file /tmp/031741ya/compare_all/path1/file4.txt
2025/07/07 03:17:49 INFO  : file4.txt: Deleted
2025/07/07 03:17:49 NOTICE: (17)  : test deleted on both paths - file8
2025/07/07 03:17:49 NOTICE: (18)  : delete-file /tmp/031741ya/compare_all/path1/file8.txt
2025/07/07 03:17:49 INFO  : file8.txt: Deleted
2025/07/07 03:17:49 NOTICE: (19)  : delete-file TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/file8.txt
2025/07/07 03:17:49 INFO  : file8.txt: Deleted
2025/07/07 03:17:49 NOTICE: (20)  : test changed on both paths - file5 (file5R, file5L)
2025/07/07 03:17:49 NOTICE: (21)  : touch-glob 2001-01-02 /tmp/031741ya/datadir/test_compare_all-kefiyud5/ file5R.txt
2025/07/07 03:17:49 NOTICE: (22)  : copy-as /tmp/031741ya/datadir/test_compare_all-kefiyud5/file5R.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/ file5.txt
2025/07/07 03:17:49 INFO  : file5R.txt: Copied (replaced existing) to: file5.txt
2025/07/07 03:17:49 NOTICE: (23)  : touch-glob 2001-03-04 /tmp/031741ya/datadir/test_compare_all-kefiyud5/ file5L.txt
2025/07/07 03:17:49 NOTICE: (24)  : copy-as /tmp/031741ya/datadir/test_compare_all-kefiyud5/file5L.txt /tmp/031741ya/compare_all/path1/ file5.txt
2025/07/07 03:17:49 INFO  : file5L.txt: Copied (replaced existing) to: file5.txt
2025/07/07 03:17:49 NOTICE: (25)  : test newer on path2 and deleted on path1 - file6
2025/07/07 03:17:49 NOTICE: (26)  : touch-copy 2001-01-02 /tmp/031741ya/datadir/test_compare_all-kefiyud5/file6.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/
2025/07/07 03:17:49 INFO  : file6.txt: Copied (replaced existing)
2025/07/07 03:17:49 NOTICE: (27)  : delete-file /tmp/031741ya/compare_all/path1/file6.txt
2025/07/07 03:17:49 INFO  : file6.txt: Deleted
2025/07/07 03:17:49 NOTICE: (28)  : test newer on path1 and deleted on path2 - file7
2025/07/07 03:17:49 NOTICE: (29)  : touch-copy 2001-01-02 /tmp/031741ya/datadir/test_compare_all-kefiyud5/file7.txt /tmp/031741ya/compare_all/path1/
2025/07/07 03:17:49 INFO  : file7.txt: Copied (replaced existing)
2025/07/07 03:17:49 NOTICE: (30)  : delete-file TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/file7.txt
2025/07/07 03:17:49 INFO  : file7.txt: Deleted
2025/07/07 03:17:49 NOTICE: (31)  : test bisync run
2025/07/07 03:17:49 NOTICE: (32)  : bisync compare-all
2025/07/07 03:17:49 NOTICE: Local file system at /tmp/031741ya/compare_all/path1: will use md5 for same-side diffs on Path1 only
2025/07/07 03:17:49 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": true,
	"HashType1": 1,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": true,
	"DownloadHash": true
}
2025/07/07 03:17:49 INFO  : Synching Path1 "/tmp/031741ya/compare_all/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/"
2025/07/07 03:17:49 INFO  : Building Path1 and Path2 listings
2025/07/07 03:17:49 INFO  : TestSMBKerberos{05jGr}: Downloading hashes...
2025/07/07 03:17:49 INFO  : Path1 checking for diffs
2025/07/07 03:17:49 INFO  : - Path1    File changed: size (larger), time (newer), hash - file2.txt
2025/07/07 03:17:49 INFO  : - Path1    File was deleted          - file4.txt
2025/07/07 03:17:49 INFO  : - Path1    File changed: size (larger), time (newer), hash - file5.txt
2025/07/07 03:17:49 INFO  : - Path1    File was deleted          - file6.txt
2025/07/07 03:17:49 INFO  : - Path1    File changed: size (larger), time (newer), hash - file7.txt
2025/07/07 03:17:49 INFO  : - Path1    File was deleted          - file8.txt
2025/07/07 03:17:49 INFO  : - Path1    File is new               - file11.txt
2025/07/07 03:17:49 INFO  : Path1:    7 changes:    1 new,    3 modified,    3 deleted
2025/07/07 03:17:49 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller,    3 hash differs)
2025/07/07 03:17:49 INFO  : Path2 checking for diffs
2025/07/07 03:17:49 INFO  : - Path2    File changed: size (larger), time (newer), hash - file1.txt
2025/07/07 03:17:49 INFO  : - Path2    File was deleted          - file3.txt
2025/07/07 03:17:49 INFO  : - Path2    File changed: size (larger), time (newer), hash - file5.txt
2025/07/07 03:17:49 INFO  : - Path2    File changed: size (larger), time (newer), hash - file6.txt
2025/07/07 03:17:49 INFO  : - Path2    File was deleted          - file7.txt
2025/07/07 03:17:49 INFO  : - Path2    File was deleted          - file8.txt
2025/07/07 03:17:49 INFO  : - Path2    File is new               - file10.txt
2025/07/07 03:17:49 INFO  : Path2:    7 changes:    1 new,    3 modified,    3 deleted
2025/07/07 03:17:49 INFO  : (Modified:    3 newer,    0 older,    3 larger,    0 smaller,    3 hash differs)
2025/07/07 03:17:49 INFO  : Applying changes
2025/07/07 03:17:49 INFO  : - Path1    Queue copy to Path2       - TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/file11.txt
2025/07/07 03:17:49 INFO  : - Path1    Queue copy to Path2       - TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/file2.txt
2025/07/07 03:17:49 INFO  : - Path2    Queue delete              - TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/file4.txt
2025/07/07 03:17:49 NOTICE: - WARNING  New or changed in both paths       - file5.txt
2025/07/07 03:17:49 NOTICE: - Path1    Renaming Path1 copy                - /tmp/031741ya/compare_all/path1/file5.txt.conflict1
2025/07/07 03:17:49 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict1
2025/07/07 03:17:49 NOTICE: - Path1    Queue copy to Path2       - TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/file5.txt.conflict1
2025/07/07 03:17:49 NOTICE: - Path2    Renaming Path2 copy                - TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/file5.txt.conflict2
2025/07/07 03:17:49 INFO  : file5.txt: Moved (server-side) to: file5.txt.conflict2
2025/07/07 03:17:49 NOTICE: - Path2    Queue copy to Path1       - /tmp/031741ya/compare_all/path1/file5.txt.conflict2
2025/07/07 03:17:49 INFO  : - Path2    Queue copy to Path1       - /tmp/031741ya/compare_all/path1/file6.txt
2025/07/07 03:17:49 INFO  : - Path1    Queue copy to Path2       - TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/file7.txt
2025/07/07 03:17:49 INFO  : - Path2    Queue copy to Path1       - /tmp/031741ya/compare_all/path1/file1.txt
2025/07/07 03:17:49 INFO  : - Path2    Queue copy to Path1       - /tmp/031741ya/compare_all/path1/file10.txt
2025/07/07 03:17:49 INFO  : - Path1    Queue delete              - /tmp/031741ya/compare_all/path1/file3.txt
2025/07/07 03:17:49 INFO  : - Path2    Do queued copies to                - Path1
2025/07/07 03:17:49 INFO  : file10.txt: Copied (new)
2025/07/07 03:17:49 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:49 INFO  : file5.txt.conflict2: Copied (new)
2025/07/07 03:17:49 INFO  : file6.txt: Copied (new)
2025/07/07 03:17:49 INFO  : file3.txt: Deleted
2025/07/07 03:17:49 INFO  : - Path1    Do queued copies to                - Path2
2025/07/07 03:17:49 INFO  : file11.txt: Copied (new)
2025/07/07 03:17:49 INFO  : file5.txt.conflict1: Copied (new)
2025/07/07 03:17:49 INFO  : file2.txt: Copied (replaced existing)
2025/07/07 03:17:49 INFO  : file7.txt: Copied (new)
2025/07/07 03:17:49 INFO  : file4.txt: Deleted
2025/07/07 03:17:49 INFO  : Updating listings
2025/07/07 03:17:49 INFO  : Validating listings for Path1 "/tmp/031741ya/compare_all/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2/"
2025/07/07 03:17:49 INFO  : Bisync successful
    bisync_test.go:560: TEST compare_all PASSED
2025/07/07 03:17:49 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-saliluy2duhu: Purge dir "031741ya/path2"
2025/07/07 03:17:49 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-saliluy2duhu: Purge dir "031741ya/compare_all"
2025/07/07 03:17:49 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-saliluy2duhu: Purge dir "031741ya"
2025/07/07 03:17:49 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-saliluy2duhu: Purge dir ""
--- FAIL: TestBisyncLocalRemote (8.21s)
    --- FAIL: TestBisyncLocalRemote/compare_all (8.10s)
=== RUN   TestBisyncRemoteRemote
2025/07/07 03:17:49 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-heledun0yipo"
2025/07/07 03:17:49 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:49 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:49 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:49 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:49 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:49 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:49 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:49 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 NOTICE: remote: TestSMBKerberos:rclone/rclone-test-heledun0yipo
=== RUN   TestBisyncRemoteRemote/check_access_filters
2025/07/07 03:17:50 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa"
2025/07/07 03:17:50 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/07/07 03:17:50 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:50 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:50 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:50 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:50 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:50 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:50 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa"
2025/07/07 03:17:50 INFO  : path1: Making directory
2025/07/07 03:17:50 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path1"
2025/07/07 03:17:50 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:50 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:50 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:50 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:50 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:50 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:50 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path1" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path1"
2025/07/07 03:17:50 DEBUG : fs cache: switching user supplied name "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa" for canonical name "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa"
2025/07/07 03:17:50 INFO  : path2: Making directory
2025/07/07 03:17:50 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path2"
2025/07/07 03:17:50 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:50 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:50 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:50 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:50 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:50 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:50 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path2" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path2"
2025/07/07 03:17:50 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access_filters/initial"
2025/07/07 03:17:50 DEBUG : Creating backend with remote "/tmp/031750qa/initdir/test_check_access_filters-pohemif2"
2025/07/07 03:17:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir-not: Making directory with metadata
2025/07/07 03:17:50 INFO  : subdir-not: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/07/07 03:17:50 DEBUG : Added delayed dir = "subdir-not", newDst=subdir-not
2025/07/07 03:17:50 DEBUG : subdir: Making directory with metadata
2025/07/07 03:17:50 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/07/07 03:17:50 DEBUG : Added delayed dir = "subdir", newDst=subdir
2025/07/07 03:17:50 DEBUG : subdirX: Making directory with metadata
2025/07/07 03:17:50 INFO  : subdirX: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/07/07 03:17:50 DEBUG : Added delayed dir = "subdirX", newDst=subdirX
2025/07/07 03:17:50 DEBUG : subdirX/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdirX/file20.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1: Making directory with metadata
2025/07/07 03:17:50 INFO  : subdirX/subdirX1: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/07/07 03:17:50 DEBUG : Added delayed dir = "subdirX/subdirX1", newDst=subdirX/subdirX1
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : file3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : subdir-not/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir-not/file20.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2: Making directory with metadata
2025/07/07 03:17:50 INFO  : subdir-not/subdir-not2: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/07/07 03:17:50 DEBUG : Added delayed dir = "subdir-not/subdir-not2", newDst=subdir-not/subdir-not2
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:50 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:50 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt
2025/07/07 03:17:50 INFO  : file3.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:50 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/07/07 03:17:50 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/subdirA: Making directory with metadata
2025/07/07 03:17:50 INFO  : subdir/subdirA: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/07/07 03:17:50 DEBUG : Added delayed dir = "subdir/subdirA", newDst=subdir/subdirA
2025/07/07 03:17:50 DEBUG : subdir/subdirB: Making directory with metadata
2025/07/07 03:17:50 INFO  : subdir/subdirB: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2025/07/07 03:17:50 DEBUG : Added delayed dir = "subdir/subdirB", newDst=subdir/subdirB
2025/07/07 03:17:50 DEBUG : subdir/subdirB/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/subdirB/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : subdir/subdirA/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/subdirA/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : Local file system at /tmp/031750qa/initdir/test_check_access_filters-pohemif2: Waiting for checks to finish
2025/07/07 03:17:50 DEBUG : Local file system at /tmp/031750qa/initdir/test_check_access_filters-pohemif2: Waiting for transfers to finish
2025/07/07 03:17:50 DEBUG : subdirX/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : subdirX/file20.txt.5028a97.partial: renamed to: subdirX/file20.txt
2025/07/07 03:17:50 INFO  : subdirX/file20.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdirX/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:50 DEBUG : subdirX/RCLONE_TEST.cf9a93ac.partial: renamed to: subdirX/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdirX/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/file30.txt.5028a97.partial: renamed to: subdirX/subdirX1/file30.txt
2025/07/07 03:17:50 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt
2025/07/07 03:17:50 INFO  : subdirX/subdirX1/file30.txt: Copied (new)
2025/07/07 03:17:50 INFO  : file4.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : subdir-not/file20.txt.5028a97.partial: renamed to: subdir-not/file20.txt
2025/07/07 03:17:50 INFO  : subdir-not/file20.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:50 DEBUG : subdir-not/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir-not/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir-not/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/RCLONE_TEST.cf9a93ac.partial: renamed to: subdirX/subdirX1/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdirX/subdirX1/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/file30.txt.5028a97.partial: renamed to: subdir-not/subdir-not2/file30.txt
2025/07/07 03:17:50 INFO  : subdir-not/subdir-not2/file30.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir-not/subdir-not2/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir-not/subdir-not2/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirB/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : subdir/subdirB/file30.txt.5028a97.partial: renamed to: subdir/subdirB/file30.txt
2025/07/07 03:17:50 INFO  : subdir/subdirB/file30.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:50 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt
2025/07/07 03:17:50 INFO  : subdir/file20.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirB/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:50 DEBUG : subdir/subdirB/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/subdirB/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir/subdirB/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirA/RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:50 DEBUG : subdir/subdirA/file30.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : subdir/subdirA/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/subdirA/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir/subdirA/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirA/file30.txt.5028a97.partial: renamed to: subdir/subdirA/file30.txt
2025/07/07 03:17:50 INFO  : subdir/subdirA/file30.txt: Copied (new)
2025/07/07 03:17:50 INFO  : subdir-not/subdir-not2: Set directory modification time (using SetModTime)
2025/07/07 03:17:50 INFO  : subdir/subdirA: Set directory modification time (using SetModTime)
2025/07/07 03:17:50 INFO  : subdir/subdirB: Set directory modification time (using SetModTime)
2025/07/07 03:17:50 INFO  : subdirX/subdirX1: Set directory modification time (using SetModTime)
2025/07/07 03:17:50 INFO  : subdirX: Set directory modification time (using SetModTime)
2025/07/07 03:17:50 INFO  : subdir-not: Set directory modification time (using SetModTime)
2025/07/07 03:17:50 INFO  : subdir: Set directory modification time (using SetModTime)
2025/07/07 03:17:50 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_check_access_filters/modfiles"
2025/07/07 03:17:50 DEBUG : Creating backend with remote "/tmp/031750qa/datadir/test_check_access_filters-junumuz3"
2025/07/07 03:17:50 DEBUG : exclude-other-filtersfile.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : include-other-filtersfile.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : Local file system at /tmp/031750qa/datadir/test_check_access_filters-junumuz3: Waiting for checks to finish
2025/07/07 03:17:50 DEBUG : Local file system at /tmp/031750qa/datadir/test_check_access_filters-junumuz3: Waiting for transfers to finish
2025/07/07 03:17:50 DEBUG : include-other-filtersfile.txt: md5 = 2ec13b2813141ed088e5978ef5a47b0e OK
2025/07/07 03:17:50 DEBUG : include-other-filtersfile.txt.5fb1cd78.partial: renamed to: include-other-filtersfile.txt
2025/07/07 03:17:50 INFO  : include-other-filtersfile.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : exclude-other-filtersfile.txt: md5 = 5fcc6205d7df1c2e9ed3a15a1356b345 OK
2025/07/07 03:17:50 DEBUG : exclude-other-filtersfile.txt.9180e6d6.partial: renamed to: exclude-other-filtersfile.txt
2025/07/07 03:17:50 INFO  : exclude-other-filtersfile.txt: Copied (new)
2025/07/07 03:17:50 ERROR : error listing: directory not found
2025/07/07 03:17:50 ERROR : error listing: directory not found
2025/07/07 03:17:50 NOTICE: checking initFs Local file system at /tmp/031750qa/initdir/test_check_access_filters-pohemif2
2025/07/07 03:17:50 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 INFO  : subdir-not: Making directory
2025/07/07 03:17:50 INFO  : subdir: Making directory
2025/07/07 03:17:50 INFO  : subdirX: Making directory
2025/07/07 03:17:50 DEBUG : subdirX/file20.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdirX/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 INFO  : subdirX/subdirX1: Making directory
2025/07/07 03:17:50 DEBUG : subdir-not/file20.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir-not/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 INFO  : subdir-not/subdir-not2: Making directory
2025/07/07 03:17:50 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 INFO  : subdir/subdirA: Making directory
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt
2025/07/07 03:17:50 INFO  : file3.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:50 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:50 INFO  : subdir/subdirB: Making directory
2025/07/07 03:17:50 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/07/07 03:17:50 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirB/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/subdirB/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/subdirA/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/subdirA/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt
2025/07/07 03:17:50 INFO  : file4.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path1: Waiting for checks to finish
2025/07/07 03:17:50 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path1: Waiting for transfers to finish
2025/07/07 03:17:50 DEBUG : subdirX/RCLONE_TEST.cf9a93ac.partial: renamed to: subdirX/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdirX/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/file20.txt.5028a97.partial: renamed to: subdir-not/file20.txt
2025/07/07 03:17:50 INFO  : subdir-not/file20.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir-not/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir-not/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt
2025/07/07 03:17:50 INFO  : subdir/file20.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:50 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/RCLONE_TEST.cf9a93ac.partial: renamed to: subdirX/subdirX1/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdirX/subdirX1/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/file30.txt.5028a97.partial: renamed to: subdirX/subdirX1/file30.txt
2025/07/07 03:17:50 INFO  : subdirX/subdirX1/file30.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirB/file30.txt.5028a97.partial: renamed to: subdir/subdirB/file30.txt
2025/07/07 03:17:50 INFO  : subdir/subdirB/file30.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirB/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/subdirB/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir/subdirB/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirA/file30.txt.5028a97.partial: renamed to: subdir/subdirA/file30.txt
2025/07/07 03:17:50 INFO  : subdir/subdirA/file30.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdirX/file20.txt.5028a97.partial: renamed to: subdirX/file20.txt
2025/07/07 03:17:50 INFO  : subdirX/file20.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirA/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/subdirA/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir/subdirA/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/file30.txt.5028a97.partial: renamed to: subdir-not/subdir-not2/file30.txt
2025/07/07 03:17:50 INFO  : subdir-not/subdir-not2/file30.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir-not/subdir-not2/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir-not/subdir-not2/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 NOTICE: checking Path1 smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path1
2025/07/07 03:17:50 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file3.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file4.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 INFO  : subdir-not: Making directory
2025/07/07 03:17:50 INFO  : subdir: Making directory
2025/07/07 03:17:50 INFO  : subdirX: Making directory
2025/07/07 03:17:50 DEBUG : subdirX/file20.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir-not/file20.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdirX/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir-not/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 INFO  : subdirX/subdirX1: Making directory
2025/07/07 03:17:50 INFO  : subdir-not/subdir-not2: Making directory
2025/07/07 03:17:50 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 INFO  : subdir/subdirA: Making directory
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:50 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:50 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : file3.txt.5028a97.partial: renamed to: file3.txt
2025/07/07 03:17:50 INFO  : file3.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdirX/file20.txt.5028a97.partial: renamed to: subdirX/file20.txt
2025/07/07 03:17:50 INFO  : subdirX/file20.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir-not/file20.txt.5028a97.partial: renamed to: subdir-not/file20.txt
2025/07/07 03:17:50 INFO  : subdir-not/file20.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdirX/RCLONE_TEST.cf9a93ac.partial: renamed to: subdirX/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdirX/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir-not/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir-not/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : file4.txt.5028a97.partial: renamed to: file4.txt
2025/07/07 03:17:50 INFO  : file4.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt
2025/07/07 03:17:50 INFO  : subdir/file20.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/file30.txt.5028a97.partial: renamed to: subdirX/subdirX1/file30.txt
2025/07/07 03:17:50 INFO  : subdirX/subdirX1/file30.txt: Copied (new)
2025/07/07 03:17:50 INFO  : subdir/subdirB: Making directory
2025/07/07 03:17:50 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/07/07 03:17:50 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirB/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/subdirB/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/subdirA/file30.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : subdir/subdirA/RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path2: Waiting for checks to finish
2025/07/07 03:17:50 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path2: Waiting for transfers to finish
2025/07/07 03:17:50 DEBUG : subdirX/subdirX1/RCLONE_TEST.cf9a93ac.partial: renamed to: subdirX/subdirX1/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdirX/subdirX1/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/file30.txt.5028a97.partial: renamed to: subdir-not/subdir-not2/file30.txt
2025/07/07 03:17:50 INFO  : subdir-not/subdir-not2/file30.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir-not/subdir-not2/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir-not/subdir-not2/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir-not/subdir-not2/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirB/file30.txt.5028a97.partial: renamed to: subdir/subdirB/file30.txt
2025/07/07 03:17:50 INFO  : subdir/subdirB/file30.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirB/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/subdirB/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir/subdirB/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirA/RCLONE_TEST.cf9a93ac.partial: renamed to: subdir/subdirA/RCLONE_TEST
2025/07/07 03:17:50 INFO  : subdir/subdirA/RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : subdir/subdirA/file30.txt.5028a97.partial: renamed to: subdir/subdirA/file30.txt
2025/07/07 03:17:50 INFO  : subdir/subdirA/file30.txt: Copied (new)
2025/07/07 03:17:50 NOTICE: checking path2 smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path2
2025/07/07 03:17:50 NOTICE: (01)  : test check-access-filters
2025/07/07 03:17:50 NOTICE: (02)  : test EXCLUDE - OTHER TESTS
2025/07/07 03:17:50 NOTICE: (03)  : copy-file /tmp/031750qa/datadir/test_check_access_filters-junumuz3/exclude-other-filtersfile.txt /tmp/031750qa/workdir/
2025/07/07 03:17:50 INFO  : exclude-other-filtersfile.txt: Copied (new)
2025/07/07 03:17:50 NOTICE: (04)  : test resync to get the filters file md5 built.
2025/07/07 03:17:50 NOTICE: (05)  : bisync resync filters-file=/tmp/031750qa/workdir/exclude-other-filtersfile.txt
    bisync_test.go:977: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:977
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:988
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:1052
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:747
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:494
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358
        	Error:      	Received unexpected error:
        	            	Update ReadFrom failed: write rclone-test-heledun0yipo\031750qa\check_access_filters\path2\modtime_write_test: invalid response error: signing required
        	Test:       	TestBisyncRemoteRemote/check_access_filters
=== RUN   TestBisyncRemoteRemote/ext_paths
2025/07/07 03:17:50 DEBUG : fs cache: switching user supplied name "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa" for canonical name "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa"
2025/07/07 03:17:50 INFO  : path1: Making directory
2025/07/07 03:17:50 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1"
2025/07/07 03:17:50 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:50 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:50 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:50 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:50 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:50 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:50 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1"
2025/07/07 03:17:50 DEBUG : fs cache: switching user supplied name "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa" for canonical name "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa"
2025/07/07 03:17:50 INFO  : path2: Making directory
2025/07/07 03:17:50 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2"
2025/07/07 03:17:50 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:50 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:50 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:50 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:50 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:50 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:50 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:50 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2"
2025/07/07 03:17:50 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ext_paths/initial"
2025/07/07 03:17:50 DEBUG : Creating backend with remote "/tmp/031750qa/initdir/test_ext_paths-wumumuj5"
2025/07/07 03:17:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : Русский.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : 測試_check file: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ: Making directory with metadata
2025/07/07 03:17:50 INFO  : 測試Русский  ěáñ: Made directory with metadata (mtime=2024-04-17T01:00:03.064427195Z)
2025/07/07 03:17:50 DEBUG : Added delayed dir = "測試Русский  ěáñ", newDst=測試Русский  ěáñ
2025/07/07 03:17:50 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:50 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/測試_check file: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : Local file system at /tmp/031750qa/initdir/test_ext_paths-wumumuj5: Waiting for checks to finish
2025/07/07 03:17:50 DEBUG : Local file system at /tmp/031750qa/initdir/test_ext_paths-wumumuj5: Waiting for transfers to finish
2025/07/07 03:17:50 DEBUG : file_enconde_mañana_funcionará.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : file_enconde_mañana_funcionará.txt.5028a97.partial: renamed to: file_enconde_mañana_funcionará.txt
2025/07/07 03:17:50 INFO  : file_enconde_mañana_funcionará.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/07/07 03:17:50 DEBUG : filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: filename_contains_ࢺ_.txt
2025/07/07 03:17:50 INFO  : filename_contains_ࢺ_.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : Русский.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : Русский.txt.5028a97.partial: renamed to: Русский.txt
2025/07/07 03:17:50 INFO  : Русский.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:50 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:50 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt.480f4fd7.partial: renamed to: 測試Русский  ěáñ/filename_contains_ě_.txt
2025/07/07 03:17:50 INFO  : 測試Русский  ěáñ/filename_contains_ě_.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : 測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:50 DEBUG : filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/測試_check file.5028a97.partial: renamed to: 測試Русский  ěáñ/測試_check file
2025/07/07 03:17:50 INFO  : 測試Русский  ěáñ/測試_check file: Copied (new)
2025/07/07 03:17:50 DEBUG : 測試_check file.5028a97.partial: renamed to: 測試_check file
2025/07/07 03:17:50 INFO  : 測試_check file: Copied (new)
2025/07/07 03:17:50 DEBUG : filename_contains_ě_.txt.480f4fd7.partial: renamed to: filename_contains_ě_.txt
2025/07/07 03:17:50 INFO  : filename_contains_ě_.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: 測試Русский  ěáñ/filename_contains_ࢺ_.txt
2025/07/07 03:17:50 INFO  : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Copied (new)
2025/07/07 03:17:50 INFO  : 測試Русский  ěáñ: Set directory modification time (using SetModTime)
2025/07/07 03:17:50 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_ext_paths/modfiles"
2025/07/07 03:17:50 DEBUG : Creating backend with remote "/tmp/031750qa/datadir/test_ext_paths-mapejat1"
2025/07/07 03:17:50 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : Local file system at /tmp/031750qa/datadir/test_ext_paths-mapejat1: Waiting for checks to finish
2025/07/07 03:17:50 DEBUG : Local file system at /tmp/031750qa/datadir/test_ext_paths-mapejat1: Waiting for transfers to finish
2025/07/07 03:17:50 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/07/07 03:17:50 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK
2025/07/07 03:17:50 DEBUG : file1.txt.917a74a1.partial: renamed to: file1.txt
2025/07/07 03:17:50 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : 測試_filtersfile.txt.1c47c956.partial: renamed to: 測試_filtersfile.txt
2025/07/07 03:17:50 INFO  : 測試_filtersfile.txt: Copied (new)
2025/07/07 03:17:50 ERROR : error listing: directory not found
2025/07/07 03:17:50 ERROR : error listing: directory not found
2025/07/07 03:17:50 NOTICE: checking initFs Local file system at /tmp/031750qa/initdir/test_ext_paths-wumumuj5
2025/07/07 03:17:50 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : Русский.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : 測試_check file: Need to transfer - File not found at Destination
2025/07/07 03:17:50 INFO  : 測試Русский  ěáñ: Making directory
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/測試_check file: Need to transfer - File not found at Destination
2025/07/07 03:17:50 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1: Waiting for checks to finish
2025/07/07 03:17:50 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1: Waiting for transfers to finish
2025/07/07 03:17:50 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:50 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:50 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:50 DEBUG : filename_contains_ě_.txt.480f4fd7.partial: renamed to: filename_contains_ě_.txt
2025/07/07 03:17:50 INFO  : filename_contains_ě_.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : Русский.txt.5028a97.partial: renamed to: Русский.txt
2025/07/07 03:17:50 INFO  : Русский.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : 測試_check file.5028a97.partial: renamed to: 測試_check file
2025/07/07 03:17:50 INFO  : 測試_check file: Copied (new)
2025/07/07 03:17:50 DEBUG : filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: filename_contains_ࢺ_.txt
2025/07/07 03:17:50 INFO  : filename_contains_ࢺ_.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt.480f4fd7.partial: renamed to: 測試Русский  ěáñ/filename_contains_ě_.txt
2025/07/07 03:17:50 INFO  : 測試Русский  ěáñ/filename_contains_ě_.txt: Copied (new)
2025/07/07 03:17:50 DEBUG : 測試Русский  ěáñ/測試_check file.5028a97.partial: renamed to: 測試Русский  ěáñ/測試_check file
2025/07/07 03:17:50 INFO  : 測試Русский  ěáñ/測試_check file: Copied (new)
2025/07/07 03:17:50 DEBUG : file_enconde_mañana_funcionará.txt.5028a97.partial: renamed to: file_enconde_mañana_funcionará.txt
2025/07/07 03:17:50 INFO  : file_enconde_mañana_funcionará.txt: Copied (new)
2025/07/07 03:17:51 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: 測試Русский  ěáñ/filename_contains_ࢺ_.txt
2025/07/07 03:17:51 INFO  : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Copied (new)
2025/07/07 03:17:51 NOTICE: checking Path1 smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1
2025/07/07 03:17:51 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:51 DEBUG : file_enconde_mañana_funcionará.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:51 DEBUG : filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:51 DEBUG : filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:51 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:51 DEBUG : Русский.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:51 DEBUG : 測試_check file: Need to transfer - File not found at Destination
2025/07/07 03:17:51 INFO  : 測試Русский  ěáñ: Making directory
2025/07/07 03:17:51 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:51 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:51 DEBUG : 測試Русский  ěáñ/測試_check file: Need to transfer - File not found at Destination
2025/07/07 03:17:51 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2: Waiting for checks to finish
2025/07/07 03:17:51 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2: Waiting for transfers to finish
2025/07/07 03:17:51 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:51 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:51 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:51 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:51 DEBUG : filename_contains_ě_.txt.480f4fd7.partial: renamed to: filename_contains_ě_.txt
2025/07/07 03:17:51 INFO  : filename_contains_ě_.txt: Copied (new)
2025/07/07 03:17:51 DEBUG : Русский.txt.5028a97.partial: renamed to: Русский.txt
2025/07/07 03:17:51 INFO  : Русский.txt: Copied (new)
2025/07/07 03:17:51 DEBUG : filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: filename_contains_ࢺ_.txt
2025/07/07 03:17:51 INFO  : filename_contains_ࢺ_.txt: Copied (new)
2025/07/07 03:17:51 DEBUG : 測試Русский  ěáñ/filename_contains_ě_.txt.480f4fd7.partial: renamed to: 測試Русский  ěáñ/filename_contains_ě_.txt
2025/07/07 03:17:51 INFO  : 測試Русский  ěáñ/filename_contains_ě_.txt: Copied (new)
2025/07/07 03:17:51 DEBUG : 測試Русский  ěáñ/filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: 測試Русский  ěáñ/filename_contains_ࢺ_.txt
2025/07/07 03:17:51 INFO  : 測試Русский  ěáñ/filename_contains_ࢺ_.txt: Copied (new)
2025/07/07 03:17:51 DEBUG : 測試Русский  ěáñ/測試_check file.5028a97.partial: renamed to: 測試Русский  ěáñ/測試_check file
2025/07/07 03:17:51 INFO  : 測試Русский  ěáñ/測試_check file: Copied (new)
2025/07/07 03:17:51 DEBUG : file_enconde_mañana_funcionará.txt.5028a97.partial: renamed to: file_enconde_mañana_funcionará.txt
2025/07/07 03:17:51 INFO  : file_enconde_mañana_funcionará.txt: Copied (new)
2025/07/07 03:17:51 DEBUG : 測試_check file.5028a97.partial: renamed to: 測試_check file
2025/07/07 03:17:51 INFO  : 測試_check file: Copied (new)
2025/07/07 03:17:51 NOTICE: checking path2 smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2
2025/07/07 03:17:51 NOTICE: (01)  : test extended-char-paths
2025/07/07 03:17:51 NOTICE: (02)  : fix-names TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский{spc}{spc}ěáñ/
2025/07/07 03:17:51 ERROR : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ-rclone-move-gayudiy3: Server side directory move failed: directory not found
2025/07/07 03:17:51 INFO  : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2025/07/07 03:17:51 ERROR : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ-rclone-move-gayudiy3: error reading source root directory: directory not found
2025/07/07 03:17:51 NOTICE: (03)  : fix-names TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский{spc}{spc}ěáñ/
2025/07/07 03:17:51 ERROR : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ-rclone-move-yoyeqar1: Server side directory move failed: directory not found
2025/07/07 03:17:51 INFO  : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2025/07/07 03:17:51 ERROR : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ-rclone-move-yoyeqar1: error reading source root directory: directory not found
2025/07/07 03:17:51 NOTICE: (04)  : fix-names TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file
2025/07/07 03:17:51 NOTICE: (05)  : fix-names TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file
2025/07/07 03:17:51 NOTICE: (06)  : fix-names TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt
2025/07/07 03:17:51 NOTICE: (07)  : fix-names TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский{spc}{spc}ěáñ/filename_contains_ě_.txt
2025/07/07 03:17:51 NOTICE: (08)  : fix-names TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試_check{spc}file
2025/07/07 03:17:51 NOTICE: (09)  : fix-names TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試_check{spc}file
2025/07/07 03:17:51 NOTICE: (10)  : fix-names TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file
2025/07/07 03:17:51 NOTICE: (11)  : fix-names TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский{spc}{spc}ěáñ/測試_check{spc}file
2025/07/07 03:17:51 NOTICE: (12)  : test resync subdirs with extended chars
2025/07/07 03:17:51 NOTICE: (13)  : bisync subdir=測試Русский{spc}{spc}ěáñ resync
2025/07/07 03:17:51 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:51 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:51 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ/"
2025/07/07 03:17:51 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:51 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:51 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:51 INFO  : Resync updating listings
2025/07/07 03:17:51 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ/"
2025/07/07 03:17:51 INFO  : Bisync successful
2025/07/07 03:17:51 NOTICE: (14)  : copy-listings resync
2025/07/07 03:17:51 NOTICE: (15)  : test place new files with extended chars on each side
2025/07/07 03:17:51 NOTICE: (16)  : touch-glob 2001-01-02 /tmp/031750qa/datadir/test_ext_paths-mapejat1/ file1.txt
2025/07/07 03:17:51 NOTICE: (17)  : copy-as /tmp/031750qa/datadir/test_ext_paths-mapejat1/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский{spc}{spc}ěáñ 測試_file1p1
2025/07/07 03:17:51 INFO  : file1.txt: Copied (new) to: 測試_file1p1
2025/07/07 03:17:51 NOTICE: (18)  : copy-as /tmp/031750qa/datadir/test_ext_paths-mapejat1/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский{spc}{spc}ěáñ 測試_file1p2
2025/07/07 03:17:51 INFO  : file1.txt: Copied (new) to: 測試_file1p2
2025/07/07 03:17:51 NOTICE: (19)  : test normal sync of subdirs with extended chars
2025/07/07 03:17:51 NOTICE: (20)  : bisync subdir=測試Русский{spc}{spc}ěáñ
2025/07/07 03:17:51 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:51 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:51 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ/"
2025/07/07 03:17:51 INFO  : Building Path1 and Path2 listings
2025/07/07 03:17:51 INFO  : Path1 checking for diffs
2025/07/07 03:17:51 INFO  : - Path1    File is new               - 測試_file1p1
2025/07/07 03:17:51 INFO  : Path1:    1 changes:    1 new,    0 modified,    0 deleted
2025/07/07 03:17:51 INFO  : Path2 checking for diffs
2025/07/07 03:17:51 INFO  : - Path2    File is new               - 測試_file1p2
2025/07/07 03:17:51 INFO  : Path2:    1 changes:    1 new,    0 modified,    0 deleted
2025/07/07 03:17:51 INFO  : Applying changes
2025/07/07 03:17:51 INFO  : - Path1    Queue copy to Path2       - TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ/測試_file1p1
2025/07/07 03:17:51 INFO  : - Path2    Queue copy to Path1       - TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ/測試_file1p2
2025/07/07 03:17:51 INFO  : - Path2    Do queued copies to                - Path1
2025/07/07 03:17:51 INFO  : 測試_file1p2: Copied (new)
2025/07/07 03:17:51 INFO  : - Path1    Do queued copies to                - Path2
2025/07/07 03:17:52 INFO  : 測試_file1p1: Copied (new)
2025/07/07 03:17:52 INFO  : Updating listings
2025/07/07 03:17:52 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ/"
2025/07/07 03:17:52 INFO  : Bisync successful
2025/07/07 03:17:52 NOTICE: (21)  : move-listings normal-sync
2025/07/07 03:17:52 NOTICE: (22)  : test check-filename with extended chars. check should fail.
2025/07/07 03:17:52 NOTICE: (23)  : bisync resync
2025/07/07 03:17:52 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:52 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:52 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:52 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:52 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:52 INFO  : Resync updating listings
2025/07/07 03:17:52 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Bisync successful
2025/07/07 03:17:52 NOTICE: (24)  : delete-file TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский{spc}{spc}ěáñ/測試_check{spc}file
2025/07/07 03:17:52 INFO  : 測試_check file: Deleted
2025/07/07 03:17:52 NOTICE: (25)  : bisync check-access check-filename=測試_check{spc}file
2025/07/07 03:17:52 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:52 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:52 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Building Path1 and Path2 listings
2025/07/07 03:17:52 INFO  : Path1 checking for diffs
2025/07/07 03:17:52 INFO  : - Path1    File was deleted          - 測試Русский  ěáñ/測試_check file
2025/07/07 03:17:52 INFO  : Path1:    1 changes:    0 new,    0 modified,    1 deleted
2025/07/07 03:17:52 INFO  : Path2 checking for diffs
2025/07/07 03:17:52 INFO  : Checking access health
2025/07/07 03:17:52 ERROR : Access test failed: Path1 count 1, Path2 count 2 - 測試_check file
2025/07/07 03:17:52 ERROR : -          Access test failed: Path2 file not found in Path1 - 測試Русский  ěáñ/測試_check file
2025/07/07 03:17:52 ERROR : Bisync critical error: check file check failed
2025/07/07 03:17:52 ERROR : Bisync aborted. Must run --resync to recover.
2025/07/07 03:17:52 NOTICE: Bisync error: bisync aborted
2025/07/07 03:17:52 NOTICE: (26)  : copy-listings check-access-fail
2025/07/07 03:17:52 NOTICE: (27)  : test check-filename with extended chars. check should pass.
2025/07/07 03:17:52 NOTICE: (28)  : bisync resync
2025/07/07 03:17:52 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:52 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:52 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:52 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:52 INFO  : 測試Русский  ěáñ/測試_check file: Copied (new)
2025/07/07 03:17:52 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:52 INFO  : Resync updating listings
2025/07/07 03:17:52 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Bisync successful
2025/07/07 03:17:52 NOTICE: (29)  : bisync check-access check-filename=測試_check{spc}file
2025/07/07 03:17:52 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:52 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:52 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Building Path1 and Path2 listings
2025/07/07 03:17:52 INFO  : Path1 checking for diffs
2025/07/07 03:17:52 INFO  : Path2 checking for diffs
2025/07/07 03:17:52 INFO  : Checking access health
2025/07/07 03:17:52 INFO  : Found 2 matching "測試_check file" files on both paths
2025/07/07 03:17:52 INFO  : No changes found
2025/07/07 03:17:52 INFO  : Updating listings
2025/07/07 03:17:52 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Bisync successful
2025/07/07 03:17:52 NOTICE: (30)  : move-listings check-access-pass
2025/07/07 03:17:52 NOTICE: (31)  : test filters-file path with extended chars - masks /fileZ.txt
2025/07/07 03:17:52 NOTICE: (32)  : copy-file /tmp/031750qa/datadir/test_ext_paths-mapejat1/測試_filtersfile.txt /tmp/031750qa/workdir/
2025/07/07 03:17:52 INFO  : 測試_filtersfile.txt: Copied (new)
2025/07/07 03:17:52 NOTICE: (33)  : bisync filters-file=/tmp/031750qa/workdir/測試_filtersfile.txt resync
2025/07/07 03:17:52 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:52 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:52 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Using filters file /tmp/031750qa/workdir/測試_filtersfile.txt
2025/07/07 03:17:52 INFO  : Storing filters file hash to /tmp/031750qa/workdir/測試_filtersfile.txt.md5
2025/07/07 03:17:52 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:52 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:52 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:52 INFO  : Resync updating listings
2025/07/07 03:17:52 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Bisync successful
2025/07/07 03:17:52 NOTICE: (34)  : copy-as /tmp/031750qa/datadir/test_ext_paths-mapejat1/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/ fileZ.txt
2025/07/07 03:17:52 INFO  : file1.txt: Copied (new) to: fileZ.txt
2025/07/07 03:17:52 NOTICE: (35)  : bisync filters-file=/tmp/031750qa/workdir/測試_filtersfile.txt
2025/07/07 03:17:52 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:52 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:52 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Using filters file /tmp/031750qa/workdir/測試_filtersfile.txt
2025/07/07 03:17:52 INFO  : Building Path1 and Path2 listings
2025/07/07 03:17:52 INFO  : Path1 checking for diffs
2025/07/07 03:17:52 INFO  : Path2 checking for diffs
2025/07/07 03:17:52 INFO  : No changes found
2025/07/07 03:17:52 INFO  : Updating listings
2025/07/07 03:17:52 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/"
2025/07/07 03:17:52 INFO  : Bisync successful
    bisync_test.go:560: TEST ext_paths PASSED
=== RUN   TestBisyncRemoteRemote/normalization
2025/07/07 03:17:52 DEBUG : fs cache: switching user supplied name "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa" for canonical name "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa"
2025/07/07 03:17:52 INFO  : path1: Making directory
2025/07/07 03:17:52 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1"
2025/07/07 03:17:52 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:52 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:52 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:52 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:52 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:52 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:52 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:52 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:52 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1"
2025/07/07 03:17:52 DEBUG : fs cache: switching user supplied name "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa" for canonical name "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa"
2025/07/07 03:17:52 INFO  : path2: Making directory
2025/07/07 03:17:52 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2"
2025/07/07 03:17:52 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:52 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:52 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:52 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:52 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:52 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:52 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:52 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:52 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2"
2025/07/07 03:17:52 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_normalization/initial"
2025/07/07 03:17:52 DEBUG : Creating backend with remote "/tmp/031750qa/initdir/test_normalization-liyevid1"
2025/07/07 03:17:52 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ: Making directory with metadata
2025/07/07 03:17:52 INFO  : 測試_Русский_ _ _ě_áñ: Made directory with metadata (mtime=2024-01-25T05:00:02.874776175Z)
2025/07/07 03:17:52 DEBUG : Added delayed dir = "測試_Русский_ _ _ě_áñ", newDst=測試_Русский_ _ _ě_áñ
2025/07/07 03:17:52 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:52 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : Local file system at /tmp/031750qa/initdir/test_normalization-liyevid1: Waiting for checks to finish
2025/07/07 03:17:52 DEBUG : Local file system at /tmp/031750qa/initdir/test_normalization-liyevid1: Waiting for transfers to finish
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:52 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.5028a97.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file
2025/07/07 03:17:52 INFO  : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new)
2025/07/07 03:17:52 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:52 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.480f4fd7.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt
2025/07/07 03:17:52 INFO  : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new)
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: md5 = 0033328434f9662a7dae0d1aee7768b6 OK
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt
2025/07/07 03:17:52 INFO  : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new)
2025/07/07 03:17:52 INFO  : 測試_Русский_ _ _ě_áñ: Set directory modification time (using SetModTime)
2025/07/07 03:17:52 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_normalization/modfiles"
2025/07/07 03:17:52 DEBUG : Creating backend with remote "/tmp/031750qa/datadir/test_normalization-wegihap2"
2025/07/07 03:17:52 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : 測試_filtersfile.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : Local file system at /tmp/031750qa/datadir/test_normalization-wegihap2: Waiting for checks to finish
2025/07/07 03:17:52 DEBUG : Local file system at /tmp/031750qa/datadir/test_normalization-wegihap2: Waiting for transfers to finish
2025/07/07 03:17:52 DEBUG : file1.txt: md5 = 7fe98ed88552b828777d8630900346b8 OK
2025/07/07 03:17:52 DEBUG : 測試_filtersfile.txt: md5 = 1cec24a8ae7c33c49693a14d53fd6a96 OK
2025/07/07 03:17:52 DEBUG : file1.txt.925c801f.partial: renamed to: file1.txt
2025/07/07 03:17:52 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:52 DEBUG : 測試_filtersfile.txt.e8d47346.partial: renamed to: 測試_filtersfile.txt
2025/07/07 03:17:52 INFO  : 測試_filtersfile.txt: Copied (new)
2025/07/07 03:17:52 ERROR : error listing: directory not found
2025/07/07 03:17:52 ERROR : error listing: directory not found
2025/07/07 03:17:52 NOTICE: checking initFs Local file system at /tmp/031750qa/initdir/test_normalization-liyevid1
2025/07/07 03:17:52 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:52 INFO  : 測試_Русский_ _ _ě_áñ: Making directory
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path1: Waiting for checks to finish
2025/07/07 03:17:52 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path1: Waiting for transfers to finish
2025/07/07 03:17:52 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:52 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.5028a97.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file
2025/07/07 03:17:52 INFO  : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new)
2025/07/07 03:17:52 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:52 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.480f4fd7.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt
2025/07/07 03:17:52 INFO  : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new)
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt
2025/07/07 03:17:52 INFO  : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new)
2025/07/07 03:17:52 NOTICE: checking Path1 smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path1
2025/07/07 03:17:52 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:52 INFO  : 測試_Русский_ _ _ě_áñ: Making directory
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file: Need to transfer - File not found at Destination
2025/07/07 03:17:52 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path2: Waiting for checks to finish
2025/07/07 03:17:52 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path2: Waiting for transfers to finish
2025/07/07 03:17:53 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt.480f4fd7.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt
2025/07/07 03:17:53 INFO  : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Copied (new)
2025/07/07 03:17:53 DEBUG : 測試_Русский_ _ _ě_áñ/測試_check file.5028a97.partial: renamed to: 測試_Русский_ _ _ě_áñ/測試_check file
2025/07/07 03:17:53 INFO  : 測試_Русский_ _ _ě_áñ/測試_check file: Copied (new)
2025/07/07 03:17:53 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:53 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:53 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:53 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:53 DEBUG : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt.480f4fd7.partial: renamed to: 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt
2025/07/07 03:17:53 INFO  : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Copied (new)
2025/07/07 03:17:53 NOTICE: checking path2 smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path2
2025/07/07 03:17:53 NOTICE: (01)  : test normalization
2025/07/07 03:17:53 NOTICE: (02)  : touch-copy 2001-01-02 /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/
2025/07/07 03:17:53 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:53 NOTICE: (03)  : test initial bisync
2025/07/07 03:17:53 NOTICE: (04)  : bisync resync
2025/07/07 03:17:53 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:53 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:53 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:53 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:53 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:53 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:53 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:53 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:53 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:53 INFO  : Resync updating listings
2025/07/07 03:17:53 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:53 INFO  : Bisync successful
2025/07/07 03:17:53 NOTICE: (05)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/07/07 03:17:53 INFO  : file1.txt: Copied (new) to: 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/07/07 03:17:53 NOTICE: (06)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/folder éééö.txt
2025/07/07 03:17:53 INFO  : file1.txt: Copied (new) to: éééö.txt
2025/07/07 03:17:53 NOTICE: (07)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/folder HeLlO,wOrLd!.txt
2025/07/07 03:17:53 INFO  : file1.txt: Copied (new) to: HeLlO,wOrLd!.txt
2025/07/07 03:17:53 NOTICE: (08)  : touch-copy 2001-01-03 /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/
2025/07/07 03:17:53 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:53 NOTICE: (09)  : copy-as-NFD /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/folder éééö.txt
2025/07/07 03:17:53 INFO  : file1.txt: Copied (new) to: éééö.txt
2025/07/07 03:17:53 NOTICE: (10)  : copy-as-NFD /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/folder hello,WORLD!.txt
2025/07/07 03:17:54 INFO  : file1.txt: Copied (new) to: hello,WORLD!.txt
2025/07/07 03:17:54 NOTICE: (11)  : test bisync run with fix-case
2025/07/07 03:17:54 NOTICE: (12)  : bisync fix-case
2025/07/07 03:17:54 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:54 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:54 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:54 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:54 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:54 INFO  : Building Path1 and Path2 listings
2025/07/07 03:17:54 INFO  : Path1 checking for diffs
2025/07/07 03:17:54 INFO  : - Path1    File is new               - folder/HeLlO,wOrLd!.txt
2025/07/07 03:17:54 INFO  : - Path1    File is new               - folder/éééö.txt
2025/07/07 03:17:54 INFO  : - Path1    File is new               - "測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/07/07 03:17:54 INFO  : Path1:    3 changes:    3 new,    0 modified,    0 deleted
2025/07/07 03:17:54 INFO  : Path2 checking for diffs
2025/07/07 03:17:54 INFO  : - Path2    File changed: size (larger), time (newer) - file1.txt
2025/07/07 03:17:54 INFO  : - Path2    File is new               - folder/éééö.txt
2025/07/07 03:17:54 INFO  : - Path2    File is new               - folder/hello,WORLD!.txt
2025/07/07 03:17:54 INFO  : Path2:    3 changes:    2 new,    1 modified,    0 deleted
2025/07/07 03:17:54 INFO  : (Modified:    1 newer,    0 older,    1 larger,    0 smaller)
2025/07/07 03:17:54 INFO  : Applying changes
2025/07/07 03:17:54 INFO  : Can't compare hashes, so using check --download for safety. (Use --size-only or --ignore-checksum to disable)
2025/07/07 03:17:54 INFO  : Checking potential conflicts...
2025/07/07 03:17:54 NOTICE: smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path2: 0 differences found
2025/07/07 03:17:54 NOTICE: smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path2: 2 matching files
2025/07/07 03:17:54 INFO  : Finished checking the potential conflicts. %!s(<nil>)
2025/07/07 03:17:54 NOTICE: - WARNING  New or changed in both paths       - folder/HeLlO,wOrLd!.txt
2025/07/07 03:17:54 INFO  : folder/hello,WORLD!.txt: Files are equal but will copy anyway to fix case to folder/HeLlO,wOrLd!.txt
2025/07/07 03:17:54 NOTICE: - WARNING  New or changed in both paths       - folder/éééö.txt
2025/07/07 03:17:54 INFO  : folder/éééö.txt: Files are equal but will copy anyway to fix case to folder/éééö.txt
2025/07/07 03:17:54 INFO  : - Path1    Queue copy to Path2       - "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/07/07 03:17:54 INFO  : - Path2    Queue copy to Path1       - TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/file1.txt
2025/07/07 03:17:54 INFO  : - Path2    Do queued copies to                - Path1
2025/07/07 03:17:54 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:54 INFO  : - Path1    Do queued copies to                - Path2
2025/07/07 03:17:54 INFO  : folder/hello,WORLD!.txt: Moved (server-side) to: folder/HeLlO,wOrLd!.txt-rclone-move-johataj2
2025/07/07 03:17:54 INFO  : folder/éééö.txt: Moved (server-side) to: folder/éééö.txt-rclone-move-pujiwan3
2025/07/07 03:17:54 INFO  : folder/HeLlO,wOrLd!.txt-rclone-move-johataj2: Moved (server-side) to: folder/HeLlO,wOrLd!.txt
2025/07/07 03:17:54 INFO  : folder/hello,WORLD!.txt: Moved (server-side) to: folder/HeLlO,wOrLd!.txt
2025/07/07 03:17:54 INFO  : folder/hello,WORLD!.txt: Fixed case by renaming to: folder/HeLlO,wOrLd!.txt
2025/07/07 03:17:54 INFO  : folder/éééö.txt-rclone-move-pujiwan3: Moved (server-side) to: folder/éééö.txt
2025/07/07 03:17:54 INFO  : folder/éééö.txt: Moved (server-side) to: folder/éééö.txt
2025/07/07 03:17:54 INFO  : folder/éééö.txt: Fixed case by renaming to: folder/éééö.txt
2025/07/07 03:17:54 INFO  : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Copied (new)
2025/07/07 03:17:54 INFO  : folder/HeLlO,wOrLd!.txt: Copied (replaced existing)
2025/07/07 03:17:54 INFO  : folder/éééö.txt: Copied (replaced existing)
2025/07/07 03:17:54 INFO  : Updating listings
2025/07/07 03:17:54 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:54 INFO  : Bisync successful
2025/07/07 03:17:54 NOTICE: (13)  : purge-children TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/
2025/07/07 03:17:54 INFO  : folder/éééö.txt: Deleted
2025/07/07 03:17:54 INFO  : folder/HeLlO,wOrLd!.txt: Deleted
2025/07/07 03:17:54 INFO  : folder: Removing directory
2025/07/07 03:17:54 INFO  : 測試_Русский_ _ _ě_áñ/測試_check file: Deleted
2025/07/07 03:17:54 INFO  : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Deleted
2025/07/07 03:17:54 INFO  : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Deleted
2025/07/07 03:17:54 INFO  : 測試_Русский_ _ _ě_áñ: Removing directory
2025/07/07 03:17:54 INFO  : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Deleted
2025/07/07 03:17:54 INFO  : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Removing directory
2025/07/07 03:17:54 NOTICE: (14)  : purge-children TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/
2025/07/07 03:17:54 INFO  : folder/éééö.txt: Deleted
2025/07/07 03:17:54 INFO  : folder/HeLlO,wOrLd!.txt: Deleted
2025/07/07 03:17:54 INFO  : folder: Removing directory
2025/07/07 03:17:54 INFO  : 測試_Русский_ _ _ě_áñ/filename_contains_ࢺ_.txt: Deleted
2025/07/07 03:17:54 INFO  : 測試_Русский_ _ _ě_áñ/測試_check file: Deleted
2025/07/07 03:17:54 INFO  : 測試_Русский_ _ _ě_áñ/filename_contains_ě_.txt: Deleted
2025/07/07 03:17:54 INFO  : 測試_Русский_ _ _ě_áñ: Removing directory
2025/07/07 03:17:54 INFO  : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Deleted
2025/07/07 03:17:54 INFO  : 測試_Русский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Removing directory
2025/07/07 03:17:54 NOTICE: (15)  : touch-copy 2001-01-02 /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/
2025/07/07 03:17:54 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:54 NOTICE: (16)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/ file2.txt
2025/07/07 03:17:54 INFO  : file1.txt: Copied (new) to: file2.txt
2025/07/07 03:17:54 NOTICE: (17)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/ file3.txt
2025/07/07 03:17:54 INFO  : file1.txt: Copied (new) to: file3.txt
2025/07/07 03:17:54 NOTICE: (18)  : bisync resync
2025/07/07 03:17:54 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:54 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:54 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:54 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:54 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:54 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:54 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:54 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:54 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:54 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:54 INFO  : file3.txt: Copied (new)
2025/07/07 03:17:54 INFO  : Resync updating listings
2025/07/07 03:17:54 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:54 INFO  : Bisync successful
2025/07/07 03:17:54 NOTICE: (19)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/07/07 03:17:54 INFO  : file1.txt: Copied (new) to: 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/07/07 03:17:54 NOTICE: (20)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/newfolder éééö.txt
2025/07/07 03:17:55 INFO  : file1.txt: Copied (new) to: éééö.txt
2025/07/07 03:17:55 NOTICE: (21)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/newfolder HeLlO,wOrLd!.txt
2025/07/07 03:17:55 INFO  : file1.txt: Copied (new) to: HeLlO,wOrLd!.txt
2025/07/07 03:17:55 NOTICE: (22)  : touch-copy 2001-01-03 /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/
2025/07/07 03:17:55 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:55 NOTICE: (23)  : copy-as-NFD /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/newfolder éééö.txt
2025/07/07 03:17:55 INFO  : file1.txt: Copied (new) to: éééö.txt
2025/07/07 03:17:55 NOTICE: (24)  : copy-as-NFD /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/newfolder hello,WORLD!.txt
2025/07/07 03:17:55 INFO  : file1.txt: Copied (new) to: hello,WORLD!.txt
2025/07/07 03:17:55 NOTICE: (25)  : test bisync run with normalization
2025/07/07 03:17:55 NOTICE: (26)  : bisync norm force
2025/07/07 03:17:55 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:55 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:55 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:55 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:55 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:55 INFO  : Building Path1 and Path2 listings
2025/07/07 03:17:55 INFO  : Path1 checking for diffs
2025/07/07 03:17:55 INFO  : - Path1    File is new               - newfolder/HeLlO,wOrLd!.txt
2025/07/07 03:17:55 INFO  : - Path1    File is new               - newfolder/éééö.txt
2025/07/07 03:17:55 INFO  : - Path1    File is new               - "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/07/07 03:17:55 INFO  : Path1:    3 changes:    3 new,    0 modified,    0 deleted
2025/07/07 03:17:55 INFO  : Path2 checking for diffs
2025/07/07 03:17:55 INFO  : - Path2    File changed: time (newer) - file1.txt
2025/07/07 03:17:55 INFO  : - Path2    File is new               - newfolder/éééö.txt
2025/07/07 03:17:55 INFO  : - Path2    File is new               - newfolder/hello,WORLD!.txt
2025/07/07 03:17:55 INFO  : Path2:    3 changes:    2 new,    1 modified,    0 deleted
2025/07/07 03:17:55 INFO  : (Modified:    1 newer,    0 older)
2025/07/07 03:17:55 INFO  : Applying changes
2025/07/07 03:17:55 INFO  : Can't compare hashes, so using check --download for safety. (Use --size-only or --ignore-checksum to disable)
2025/07/07 03:17:55 INFO  : Checking potential conflicts...
2025/07/07 03:17:55 NOTICE: smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path2: 0 differences found
2025/07/07 03:17:55 NOTICE: smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path2: 2 matching files
2025/07/07 03:17:55 INFO  : Finished checking the potential conflicts. %!s(<nil>)
2025/07/07 03:17:55 NOTICE: - WARNING  New or changed in both paths       - newfolder/HeLlO,wOrLd!.txt
2025/07/07 03:17:55 INFO  : newfolder/HeLlO,wOrLd!.txt: Files are equal but will copy anyway to update modtime (will not rename)
2025/07/07 03:17:55 INFO  : - Path2    Queue copy to Path1       - TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/newfolder/HeLlO,wOrLd!.txt
2025/07/07 03:17:55 NOTICE: - WARNING  New or changed in both paths       - newfolder/éééö.txt
2025/07/07 03:17:55 INFO  : newfolder/éééö.txt: Files are equal but will copy anyway to update modtime (will not rename)
2025/07/07 03:17:55 INFO  : - Path2    Queue copy to Path1       - TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/newfolder/éééö.txt
2025/07/07 03:17:55 INFO  : - Path1    Queue copy to Path2       - "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/07/07 03:17:55 INFO  : - Path2    Queue copy to Path1       - TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/file1.txt
2025/07/07 03:17:55 INFO  : - Path2    Do queued copies to                - Path1
2025/07/07 03:17:55 INFO  : newfolder/éééö.txt: Copied (replaced existing) to: newfolder/éééö.txt
2025/07/07 03:17:55 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:55 INFO  : newfolder/hello,WORLD!.txt: Copied (replaced existing) to: newfolder/HeLlO,wOrLd!.txt
2025/07/07 03:17:55 INFO  : - Path1    Do queued copies to                - Path2
2025/07/07 03:17:55 INFO  : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Copied (new)
2025/07/07 03:17:55 INFO  : Updating listings
2025/07/07 03:17:55 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:55 INFO  : Bisync successful
2025/07/07 03:17:55 NOTICE: (27)  : test resync
2025/07/07 03:17:55 NOTICE: (28)  : bisync resync norm
2025/07/07 03:17:55 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:55 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:55 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:55 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:55 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:55 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:55 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:55 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:55 INFO  : Resync updating listings
2025/07/07 03:17:55 INFO  : Can't compare hashes, so using check --download for safety. (Use --size-only or --ignore-checksum to disable)
2025/07/07 03:17:55 INFO  : Can't compare hashes, so using check --download for safety. (Use --size-only or --ignore-checksum to disable)
2025/07/07 03:17:55 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:55 INFO  : Bisync successful
2025/07/07 03:17:55 NOTICE: (29)  : test changed on one path
2025/07/07 03:17:55 NOTICE: (30)  : touch-copy 2001-01-05 /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/
2025/07/07 03:17:55 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:55 NOTICE: (31)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/07/07 03:17:55 INFO  : file1.txt: Copied (replaced existing) to: 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt
2025/07/07 03:17:55 NOTICE: (32)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/newfolder éééö.txt
2025/07/07 03:17:55 INFO  : file1.txt: Copied (replaced existing) to: éééö.txt
2025/07/07 03:17:55 NOTICE: (33)  : copy-as-NFC /tmp/031750qa/datadir/test_normalization-wegihap2/file1.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/newfolder HeLlO,wOrLd!.txt
2025/07/07 03:17:56 INFO  : file1.txt: Copied (replaced existing) to: HeLlO,wOrLd!.txt
2025/07/07 03:17:56 NOTICE: (34)  : bisync norm
2025/07/07 03:17:56 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:56 INFO  : ě�� áñhࢺ_測試рускийěáñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö: Copied (new)
2025/07/07 03:17:56 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:56 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:56 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:56 INFO  : Building Path1 and Path2 listings
2025/07/07 03:17:56 INFO  : Path1 checking for diffs
2025/07/07 03:17:56 INFO  : - Path1    File changed: time (newer) - newfolder/HeLlO,wOrLd!.txt
2025/07/07 03:17:56 INFO  : - Path1    File changed: time (newer) - newfolder/éééö.txt
2025/07/07 03:17:56 INFO  : - Path1    File changed: time (newer) - "測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/07/07 03:17:56 INFO  : Path1:    3 changes:    0 new,    3 modified,    0 deleted
2025/07/07 03:17:56 INFO  : (Modified:    3 newer,    0 older)
2025/07/07 03:17:56 INFO  : Path2 checking for diffs
2025/07/07 03:17:56 INFO  : - Path2    File changed: time (newer) - file1.txt
2025/07/07 03:17:56 INFO  : Path2:    1 changes:    0 new,    1 modified,    0 deleted
2025/07/07 03:17:56 INFO  : (Modified:    1 newer,    0 older)
2025/07/07 03:17:56 INFO  : Applying changes
2025/07/07 03:17:56 INFO  : - Path1    Queue copy to Path2       - TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/newfolder/hello,WORLD!.txt
2025/07/07 03:17:56 INFO  : - Path1    Queue copy to Path2       - TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/newfolder/éééö.txt
2025/07/07 03:17:56 INFO  : - Path1    Queue copy to Path2       - "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾\u200d♀️💆🏿\u200d♂️🐨🤙🏼🤮🧑🏻\u200d🔧🧑\u200d🔬éö.txt"
2025/07/07 03:17:56 INFO  : - Path2    Queue copy to Path1       - TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/file1.txt
2025/07/07 03:17:56 INFO  : - Path2    Do queued copies to                - Path1
2025/07/07 03:17:56 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:56 INFO  : - Path1    Do queued copies to                - Path2
2025/07/07 03:17:56 INFO  : newfolder/éééö.txt: Copied (replaced existing) to: newfolder/éééö.txt
2025/07/07 03:17:56 INFO  : newfolder/HeLlO,wOrLd!.txt: Copied (replaced existing) to: newfolder/hello,WORLD!.txt
2025/07/07 03:17:56 INFO  : 測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö/測試_Руский___ě_áñ👸🏼🧝🏾‍♀️💆🏿‍♂️🐨🤙🏼🤮🧑🏻‍🔧🧑‍🔬éö.txt: Copied (replaced existing)
2025/07/07 03:17:56 INFO  : Updating listings
2025/07/07 03:17:56 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/normalization/path2/"
2025/07/07 03:17:56 INFO  : Bisync successful
    bisync_test.go:560: TEST normalization PASSED
=== RUN   TestBisyncRemoteRemote/resync_modes
2025/07/07 03:17:56 DEBUG : fs cache: switching user supplied name "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa" for canonical name "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa"
2025/07/07 03:17:56 INFO  : path1: Making directory
2025/07/07 03:17:56 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1"
2025/07/07 03:17:56 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:56 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:56 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:56 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:56 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:56 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:56 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:56 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:56 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1"
2025/07/07 03:17:56 DEBUG : fs cache: switching user supplied name "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa" for canonical name "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa"
2025/07/07 03:17:56 INFO  : path2: Making directory
2025/07/07 03:17:56 DEBUG : Creating backend with remote "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2"
2025/07/07 03:17:56 DEBUG : Setting type="smb" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_TYPE
2025/07/07 03:17:56 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:56 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:56 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:56 DEBUG : TestSMBKerberos: detected overridden config - adding "{05jGr}" suffix to name
2025/07/07 03:17:56 DEBUG : Setting host="localhost" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_HOST
2025/07/07 03:17:56 DEBUG : Setting port="28633" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_PORT
2025/07/07 03:17:56 DEBUG : Setting use_kerberos="true" for "TestSMBKerberos" from environment variable RCLONE_CONFIG_TESTSMBKERBEROS_USE_KERBEROS
2025/07/07 03:17:56 DEBUG : fs cache: renaming cache item "TestSMBKerberos:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2" to be canonical "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2"
2025/07/07 03:17:56 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/initial"
2025/07/07 03:17:56 DEBUG : Creating backend with remote "/tmp/031750qa/initdir/test_resync_modes-ginotaz6"
2025/07/07 03:17:56 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : Local file system at /tmp/031750qa/initdir/test_resync_modes-ginotaz6: Waiting for checks to finish
2025/07/07 03:17:56 DEBUG : Local file system at /tmp/031750qa/initdir/test_resync_modes-ginotaz6: Waiting for transfers to finish
2025/07/07 03:17:56 DEBUG : file2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:56 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2025/07/07 03:17:56 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/07/07 03:17:56 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:56 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:56 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:56 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2025/07/07 03:17:56 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:56 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:56 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_resync_modes/modfiles"
2025/07/07 03:17:56 DEBUG : Creating backend with remote "/tmp/031750qa/datadir/test_resync_modes-rutelal7"
2025/07/07 03:17:56 DEBUG : file1L.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : file1R.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : Local file system at /tmp/031750qa/datadir/test_resync_modes-rutelal7: Waiting for checks to finish
2025/07/07 03:17:56 DEBUG : Local file system at /tmp/031750qa/datadir/test_resync_modes-rutelal7: Waiting for transfers to finish
2025/07/07 03:17:56 DEBUG : file1L.txt: md5 = ea683c03f780b76a62405456b08ae6fd OK
2025/07/07 03:17:56 DEBUG : file1R.txt: md5 = 705bb3c0ef02925739e834ca98c099c3 OK
2025/07/07 03:17:56 DEBUG : file1R.txt.cb75035e.partial: renamed to: file1R.txt
2025/07/07 03:17:56 INFO  : file1R.txt: Copied (new)
2025/07/07 03:17:56 DEBUG : file1L.txt.7d07f91a.partial: renamed to: file1L.txt
2025/07/07 03:17:56 INFO  : file1L.txt: Copied (new)
2025/07/07 03:17:56 DEBUG : file2.txt: md5 = 9fe822ddd1cb81d83aae00fa48239bd3 OK
2025/07/07 03:17:56 DEBUG : file2.txt.7cc9b07.partial: renamed to: file2.txt
2025/07/07 03:17:56 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:56 ERROR : error listing: directory not found
2025/07/07 03:17:56 ERROR : error listing: directory not found
2025/07/07 03:17:56 NOTICE: checking initFs Local file system at /tmp/031750qa/initdir/test_resync_modes-ginotaz6
2025/07/07 03:17:56 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1: Waiting for checks to finish
2025/07/07 03:17:56 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1: Waiting for transfers to finish
2025/07/07 03:17:56 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:56 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:56 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/07/07 03:17:56 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:56 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:56 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:56 NOTICE: checking Path1 smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1
2025/07/07 03:17:56 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : file2.txt: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2025/07/07 03:17:56 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2: Waiting for checks to finish
2025/07/07 03:17:56 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2: Waiting for transfers to finish
2025/07/07 03:17:56 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt
2025/07/07 03:17:56 INFO  : file1.txt: Copied (new)
2025/07/07 03:17:56 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST
2025/07/07 03:17:56 INFO  : RCLONE_TEST: Copied (new)
2025/07/07 03:17:56 DEBUG : file2.txt.5028a97.partial: renamed to: file2.txt
2025/07/07 03:17:56 INFO  : file2.txt: Copied (new)
2025/07/07 03:17:56 NOTICE: checking path2 smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2
2025/07/07 03:17:56 NOTICE: (01)  : test resync-mode
2025/07/07 03:17:56 NOTICE: (02)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/07/07 03:17:56 NOTICE: (03)  : touch-glob 2001-01-02 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1R.txt
2025/07/07 03:17:56 NOTICE: (04)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1R.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/ file1.txt
2025/07/07 03:17:56 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:56 NOTICE: (05)  : touch-glob 2001-03-04 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1L.txt
2025/07/07 03:17:56 NOTICE: (06)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1L.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/ file1.txt
2025/07/07 03:17:56 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:56 NOTICE: (07)  : test bisync run with --resync-mode=newer
2025/07/07 03:17:56 NOTICE: (08)  : bisync resync resync-mode=newer
2025/07/07 03:17:56 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:56 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:56 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:56 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:56 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:56 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:56 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:56 INFO  : Resync updating listings
2025/07/07 03:17:56 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:56 INFO  : Bisync successful
2025/07/07 03:17:56 NOTICE: (09)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/07/07 03:17:56 NOTICE: (10)  : touch-glob 2001-07-23 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1R.txt
2025/07/07 03:17:56 NOTICE: (11)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1R.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/ file1.txt
2025/07/07 03:17:56 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:56 NOTICE: (12)  : touch-glob 2001-08-26 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1L.txt
2025/07/07 03:17:56 NOTICE: (13)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1L.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/ file1.txt
2025/07/07 03:17:57 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:57 NOTICE: (14)  : test bisync run with --resync-mode=path2
2025/07/07 03:17:57 NOTICE: (15)  : bisync resync resync-mode=path2
2025/07/07 03:17:57 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:57 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:57 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:57 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:57 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:57 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:57 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:57 INFO  : Resync updating listings
2025/07/07 03:17:57 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:57 INFO  : Bisync successful
2025/07/07 03:17:57 NOTICE: (16)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/07/07 03:17:57 NOTICE: (17)  : touch-glob 2002-07-23 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1R.txt
2025/07/07 03:17:57 NOTICE: (18)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1R.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/ file1.txt
2025/07/07 03:17:57 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:57 NOTICE: (19)  : touch-glob 2002-08-26 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1L.txt
2025/07/07 03:17:57 NOTICE: (20)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1L.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/ file1.txt
2025/07/07 03:17:57 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:57 NOTICE: (21)  : test bisync run with --resync-mode=larger
2025/07/07 03:17:57 NOTICE: (22)  : bisync resync resync-mode=larger
2025/07/07 03:17:57 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:57 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:57 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:57 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:57 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:57 INFO  : file1.txt: Path2 is larger. Path1: 33, Path2: 42, Difference: 9
2025/07/07 03:17:57 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:57 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:57 INFO  : Resync updating listings
2025/07/07 03:17:57 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:57 INFO  : Bisync successful
2025/07/07 03:17:57 NOTICE: (23)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/07/07 03:17:57 NOTICE: (24)  : touch-glob 2003-07-23 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1R.txt
2025/07/07 03:17:57 NOTICE: (25)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1R.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/ file1.txt
2025/07/07 03:17:57 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:57 NOTICE: (26)  : touch-glob 2003-09-04 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1L.txt
2025/07/07 03:17:57 NOTICE: (27)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1L.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/ file1.txt
2025/07/07 03:17:57 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:57 NOTICE: (28)  : test bisync run with --resync-mode=older
2025/07/07 03:17:57 NOTICE: (29)  : bisync resync resync-mode=older
2025/07/07 03:17:57 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:57 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:57 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:57 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:57 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:57 INFO  : file1.txt: Path2 is older. Path1: 2003-09-04 00:00:00 +0000 UTC, Path2: 2003-07-23 00:00:00 +0000 UTC, Difference: 1032h0m0s
2025/07/07 03:17:57 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:57 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:57 INFO  : Resync updating listings
2025/07/07 03:17:57 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:57 INFO  : Bisync successful
2025/07/07 03:17:57 NOTICE: (30)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/07/07 03:17:57 NOTICE: (31)  : touch-glob 2004-07-23 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1R.txt
2025/07/07 03:17:57 NOTICE: (32)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1R.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/ file1.txt
2025/07/07 03:17:57 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:57 NOTICE: (33)  : touch-glob 2004-07-23 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1L.txt
2025/07/07 03:17:57 NOTICE: (34)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1L.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/ file1.txt
2025/07/07 03:17:58 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:58 NOTICE: (35)  : test bisync run with --resync-mode=smaller
2025/07/07 03:17:58 NOTICE: (36)  : bisync resync resync-mode=smaller
2025/07/07 03:17:58 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:58 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:58 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:58 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:58 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:58 INFO  : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9
2025/07/07 03:17:58 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:58 INFO  : file1.txt: Path1 is smaller. Path1: 33, Path2: 42, Difference: 9
2025/07/07 03:17:58 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:58 INFO  : Resync updating listings
2025/07/07 03:17:58 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:58 INFO  : Bisync successful
2025/07/07 03:17:58 NOTICE: (37)  : test changed on both paths and NOT identical - file1 (file1R, file1L)
2025/07/07 03:17:58 NOTICE: (38)  : touch-glob 2005-01-02 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1R.txt
2025/07/07 03:17:58 NOTICE: (39)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1R.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/ file1.txt
2025/07/07 03:17:58 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:58 NOTICE: (40)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1R.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/ file2.txt
2025/07/07 03:17:58 INFO  : file1R.txt: Copied (replaced existing) to: file2.txt
2025/07/07 03:17:58 NOTICE: (41)  : touch-glob 2006-03-04 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1L.txt
2025/07/07 03:17:58 NOTICE: (42)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1L.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/ file1.txt
2025/07/07 03:17:58 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:58 NOTICE: (43)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1L.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/ file2.txt
2025/07/07 03:17:58 INFO  : file1L.txt: Copied (replaced existing) to: file2.txt
2025/07/07 03:17:58 NOTICE: (44)  : test bisync run with --resync-mode=path1
2025/07/07 03:17:58 NOTICE: (45)  : bisync resync resync-mode=path1
2025/07/07 03:17:58 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:58 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:58 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:58 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:58 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:58 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:58 INFO  : file2.txt: Copied (replaced existing)
2025/07/07 03:17:58 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:58 INFO  : Resync updating listings
2025/07/07 03:17:58 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:58 INFO  : Bisync successful
2025/07/07 03:17:58 NOTICE: (46)  : test no winner
2025/07/07 03:17:58 NOTICE: (47)  : touch-glob 2022-02-22 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1R.txt
2025/07/07 03:17:58 NOTICE: (48)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1R.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/ file1.txt
2025/07/07 03:17:58 INFO  : file1R.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:58 NOTICE: (49)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1R.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/ file2.txt
2025/07/07 03:17:58 INFO  : file1R.txt: Copied (replaced existing) to: file2.txt
2025/07/07 03:17:58 NOTICE: (50)  : touch-glob 2022-02-22 /tmp/031750qa/datadir/test_resync_modes-rutelal7/ file1L.txt
2025/07/07 03:17:58 NOTICE: (51)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1L.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/ file1.txt
2025/07/07 03:17:59 INFO  : file1L.txt: Copied (replaced existing) to: file1.txt
2025/07/07 03:17:59 NOTICE: (52)  : copy-as /tmp/031750qa/datadir/test_resync_modes-rutelal7/file1L.txt TestSMBKerberos,host='localhost',port='28633',use_kerberos='true':rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/ file2.txt
2025/07/07 03:17:59 INFO  : file1L.txt: Copied (replaced existing) to: file2.txt
2025/07/07 03:17:59 NOTICE: (53)  : test bisync run with --resync-mode=newer
2025/07/07 03:17:59 NOTICE: (54)  : bisync resync resync-mode=newer
2025/07/07 03:17:59 INFO  : Setting --ignore-listing-checksum as neither --checksum nor --compare checksum are set.
2025/07/07 03:17:59 INFO  : Bisyncing with Comparison Settings: 
{
	"Modtime": true,
	"Size": true,
	"Checksum": false,
	"HashType1": 0,
	"HashType2": 0,
	"NoSlowHash": false,
	"SlowHashSyncOnly": false,
	"SlowHashDetected": false,
	"DownloadHash": false
}
2025/07/07 03:17:59 INFO  : Synching Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" with Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:59 INFO  : Copying Path2 files to Path1
2025/07/07 03:17:59 INFO  : - Path2    Resync is copying files to         - Path1
2025/07/07 03:17:59 INFO  : file2.txt: Copied (replaced existing)
2025/07/07 03:17:59 INFO  : file1.txt: Copied (replaced existing)
2025/07/07 03:17:59 INFO  : - Path1    Resync is copying files to         - Path2
2025/07/07 03:17:59 INFO  : Resync updating listings
2025/07/07 03:17:59 INFO  : Validating listings for Path1 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1/" vs Path2 "TestSMBKerberos{05jGr}:rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2/"
2025/07/07 03:17:59 INFO  : Bisync successful
    bisync_test.go:560: TEST resync_modes PASSED
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/file1.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/file2.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/file3.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/file4.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/file1.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/file2.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/file3.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/file4.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdir/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdir/file20.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdir-not/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdir-not/file20.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdirX/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdirX/file20.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdir-not/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdir-not/file20.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdirX/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdirX/file20.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdir/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdir/file20.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdir/subdirA/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdir/subdirA/file30.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdir/subdirB/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdir/subdirB/file30.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdir-not/subdir-not2/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdir-not/subdir-not2/file30.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdirX/subdirX1/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path1/subdirX/subdirX1/file30.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdir-not/subdir-not2/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdir-not/subdir-not2/file30.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdirX/subdirX1/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdirX/subdirX1/file30.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdir/subdirB/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdir/subdirB/file30.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdir/subdirA/RCLONE_TEST"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge object "031750qa/check_access_filters/path2/subdir/subdirA/file30.txt"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/resync_modes"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/path2"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/path1"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/normalization"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/ext_paths"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path2/subdirX/subdirX1"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path2/subdirX"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path2/subdir/subdirB"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path2/subdir/subdirA"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path2/subdir-not/subdir-not2"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path2/subdir-not"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path2/subdir"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path2"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path1/subdirX/subdirX1"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path1/subdirX"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path1/subdir/subdirB"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path1/subdir/subdirA"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path1/subdir-not/subdir-not2"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path1/subdir-not"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path1/subdir"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters/path1"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa/check_access_filters"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir "031750qa"
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo: Purge dir ""
--- FAIL: TestBisyncRemoteRemote (9.42s)
    --- FAIL: TestBisyncRemoteRemote/check_access_filters (0.68s)
    --- PASS: TestBisyncRemoteRemote/ext_paths (1.98s)
    --- PASS: TestBisyncRemoteRemote/normalization (3.62s)
    --- PASS: TestBisyncRemoteRemote/resync_modes (2.92s)
FAIL
2025/07/07 03:17:59 ERROR : error listing: directory not found
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-digaxaf0zuni: Purge dir ""
2025/07/07 03:17:59 NOTICE: purge failed to rmdir "": remove rclone-test-digaxaf0zuni: file does not exist
2025/07/07 03:17:59 NOTICE: purge failed: directory not found
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path1: Closing 9 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ-rclone-move-gayudiy3: Closing 1 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ: Closing 2 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2: Closing 8 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ: Closing 1 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-saliluy2duhu/031741ya/compare_all/path2: Closing 9 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa: Closing 1 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ: Closing 2 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path2/測試Русский  ěáñ-rclone-move-yoyeqar1: Closing 1 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path2: Closing 5 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-saliluy2duhu/031741ya: Closing 1 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1: Closing 9 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/ext_paths/path1/測試Русский  ěáñ: Closing 1 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/: Closing 1 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path1: Closing 7 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/resync_modes/path1: Closing 6 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/check_access_filters/path2: Closing 8 unused connections
2025/07/07 03:17:59 DEBUG : smb://rclone@localhost:28633/rclone/rclone-test-heledun0yipo/031750qa/normalization/path2: Closing 8 unused connections
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestSMBKerberos:rclone -verbose -test.run '^TestBisyncLocalRemote$/^compare_all$|^TestBisyncRemoteRemote$/^(check_access_filters|ext_paths|normalization|resync_modes)$'" - Finished ERROR in 18.024999635s (try 4/5): exit status 1: Failed [TestBisyncLocalRemote/compare_all TestBisyncRemoteRemote/check_access_filters]