"./sync.test -test.v -test.timeout 1h0m0s -remote TestFTPProftpd: -verbose -test.run '^(TestSyncOverlap|TestSyncOverlapWithFilter)$'" - Starting (try 3/5) 2025/03/24 01:01:43 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vonanuk9hixo" 2025/03/24 01:01:43 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/24 01:01:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/03/24 01:01:43 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/03/24 01:01:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/03/24 01:01:43 DEBUG : Setting pass="EUHOTljuNwgHICWBDfW9DTg-NAfh0cZYWIujdM3etaD_Qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/03/24 01:01:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/03/24 01:01:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{N5Xgg}" suffix to name 2025/03/24 01:01:43 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/03/24 01:01:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/03/24 01:01:43 DEBUG : Setting pass="EUHOTljuNwgHICWBDfW9DTg-NAfh0cZYWIujdM3etaD_Qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/03/24 01:01:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: Connecting to FTP server 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:21") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : Creating backend with remote "/tmp/rclone3061717785" === RUN TestSyncOverlap run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" 2025/03/24 01:01:43 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vonanuk9hixo/rclone-sync-test" 2025/03/24 01:01:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/03/24 01:01:43 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/03/24 01:01:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/03/24 01:01:43 DEBUG : Setting pass="EUHOTljuNwgHICWBDfW9DTg-NAfh0cZYWIujdM3etaD_Qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/03/24 01:01:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/03/24 01:01:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{N5Xgg}" suffix to name 2025/03/24 01:01:43 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/03/24 01:01:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/03/24 01:01:43 DEBUG : Setting pass="EUHOTljuNwgHICWBDfW9DTg-NAfh0cZYWIujdM3etaD_Qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/03/24 01:01:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: Connecting to FTP server 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: dial("tcp","172.17.0.3:21") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: > dial: conn=*fshttp.timeoutConn, err= run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:58490") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 ERROR : : error listing: directory not found 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:10452") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 ERROR : : error listing: directory not found 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:42155") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 ERROR : : error listing: directory not found 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:24283") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 ERROR : : error listing: directory not found 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:7041") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 ERROR : : error listing: directory not found --- PASS: TestSyncOverlap (0.02s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" 2025/03/24 01:01:43 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vonanuk9hixo/rclone-sync-test" 2025/03/24 01:01:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/03/24 01:01:43 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/03/24 01:01:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/03/24 01:01:43 DEBUG : Setting pass="EUHOTljuNwgHICWBDfW9DTg-NAfh0cZYWIujdM3etaD_Qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/03/24 01:01:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/03/24 01:01:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{N5Xgg}" suffix to name 2025/03/24 01:01:43 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/03/24 01:01:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/03/24 01:01:43 DEBUG : Setting pass="EUHOTljuNwgHICWBDfW9DTg-NAfh0cZYWIujdM3etaD_Qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/03/24 01:01:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: Connecting to FTP server 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: dial("tcp","172.17.0.3:21") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vonanuk9hixo/rclone-sync-test-include/layer2" 2025/03/24 01:01:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/03/24 01:01:43 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/03/24 01:01:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/03/24 01:01:43 DEBUG : Setting pass="EUHOTljuNwgHICWBDfW9DTg-NAfh0cZYWIujdM3etaD_Qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/03/24 01:01:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/03/24 01:01:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{N5Xgg}" suffix to name 2025/03/24 01:01:43 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/03/24 01:01:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/03/24 01:01:43 DEBUG : Setting pass="EUHOTljuNwgHICWBDfW9DTg-NAfh0cZYWIujdM3etaD_Qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/03/24 01:01:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-include/layer2: Connecting to FTP server 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-include/layer2: dial("tcp","172.17.0.3:21") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-include/layer2: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vonanuk9hixo/rclone-sync-test-ignore-file" 2025/03/24 01:01:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/03/24 01:01:43 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/03/24 01:01:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/03/24 01:01:43 DEBUG : Setting pass="EUHOTljuNwgHICWBDfW9DTg-NAfh0cZYWIujdM3etaD_Qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/03/24 01:01:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/03/24 01:01:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{N5Xgg}" suffix to name 2025/03/24 01:01:43 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/03/24 01:01:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/03/24 01:01:43 DEBUG : Setting pass="EUHOTljuNwgHICWBDfW9DTg-NAfh0cZYWIujdM3etaD_Qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/03/24 01:01:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-ignore-file: Connecting to FTP server 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-ignore-file: dial("tcp","172.17.0.3:21") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-ignore-file: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:42433") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: dial("tcp","172.17.0.3:40824") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:16490") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : rclone-sync-test: Excluded 2025/03/24 01:01:43 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:26894") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: Waiting for checks to finish 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: Waiting for transfers to finish 2025/03/24 01:01:43 DEBUG : Waiting for deletions to finish 2025/03/24 01:01:43 INFO : There was nothing to transfer 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:7779") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: dial("tcp","172.17.0.3:14832") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : rclone-sync-test: Excluded 2025/03/24 01:01:43 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:26265") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: Waiting for checks to finish 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: Waiting for transfers to finish 2025/03/24 01:01:43 DEBUG : Waiting for deletions to finish 2025/03/24 01:01:43 INFO : rclone-sync-test-include: Removing directory 2025/03/24 01:01:43 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not found 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: failed to delete 1 directories 2025/03/24 01:01:43 INFO : There was nothing to transfer run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:60080") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-include/layer2: dial("tcp","172.17.0.3:59448") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-include/layer2: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : rclone-sync-test: Excluded 2025/03/24 01:01:43 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:7375") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-include/layer2: Waiting for checks to finish 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-include/layer2: Waiting for transfers to finish 2025/03/24 01:01:43 DEBUG : Waiting for deletions to finish 2025/03/24 01:01:43 INFO : There was nothing to transfer run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:7816") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-include/layer2: dial("tcp","172.17.0.3:58867") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-include/layer2: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : rclone-sync-test: Excluded 2025/03/24 01:01:43 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:4752") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: Waiting for checks to finish 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: Waiting for transfers to finish 2025/03/24 01:01:43 DEBUG : Waiting for deletions to finish 2025/03/24 01:01:43 INFO : rclone-sync-test-include: Removing directory 2025/03/24 01:01:43 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not found 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: failed to delete 1 directories 2025/03/24 01:01:43 INFO : There was nothing to transfer run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:27706") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-ignore-file: dial("tcp","172.17.0.3:2603") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-ignore-file: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : : Excluded 2025/03/24 01:01:43 DEBUG : rclone-sync-test: Excluded 2025/03/24 01:01:43 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:1820") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-ignore-file: Waiting for checks to finish 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo/rclone-sync-test-ignore-file: Waiting for transfers to finish 2025/03/24 01:01:43 DEBUG : Waiting for deletions to finish 2025/03/24 01:01:43 INFO : There was nothing to transfer run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" run.go:180: Remote "ftp://172.17.0.3:21/rclone-test-vonanuk9hixo", Local "Local file system at /tmp/rclone3061717785", Modify Window "1s" 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:11133") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: Connecting to FTP server 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:21") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: Connecting to FTP server 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:15075") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:14750") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:53428") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:21") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:60795") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:37781") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:57066") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:10942") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:28649") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:59982") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:60671") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:59629") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:30916") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:41702") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:57764") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:49494") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:17650") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:45497") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:62901") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:53311") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:31031") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:28034") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:19725") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:43362") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:59859") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:17564") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:63479") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:15549") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:27844") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:27060") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:28105") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:61175") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:41792") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:32041") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:34624") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:39904") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:57954") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:62869") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:63674") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:14285") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= --- PASS: TestSyncOverlapWithFilter (0.16s) PASS 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: dial("tcp","172.17.0.3:63363") 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/24 01:01:43 DEBUG : ftp://172.17.0.3:21/rclone-test-vonanuk9hixo: Purge dir "" "./sync.test -test.v -test.timeout 1h0m0s -remote TestFTPProftpd: -verbose -test.run '^(TestSyncOverlap|TestSyncOverlapWithFilter)$'" - Finished OK in 252.88543ms (try 3/5)