"./sync.test -test.v -test.timeout 1h0m0s -remote TestFTPPureftpd: -verbose -test.run '^(TestServerSideMove|TestServerSideMoveWithFilter)$'" - Starting (try 2/5) 2025/12/17 03:43:22 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-todabup8zogu" 2025/12/17 03:43:22 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/17 03:43:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/17 03:43:22 DEBUG : Setting host="172.17.0.12" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/17 03:43:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/17 03:43:22 DEBUG : Setting pass="Xk7Yb0S-qxPkHAhS2Wfu625XL7R5lQR8z4YWIdO6BD0" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/17 03:43:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/17 03:43:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xkjfW}" suffix to name 2025/12/17 03:43:22 DEBUG : Setting host="172.17.0.12" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/17 03:43:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/17 03:43:22 DEBUG : Setting pass="Xk7Yb0S-qxPkHAhS2Wfu625XL7R5lQR8z4YWIdO6BD0" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/17 03:43:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: Connecting to FTP server 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:21") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:37258->172.17.0.12:21, err= 2025/12/17 03:43:22 DEBUG : Creating backend with remote "/tmp/rclone3988893505" === RUN TestServerSideMove run.go:185: Remote "ftp://172.17.0.12:21/rclone-test-todabup8zogu", Local "Local file system at /tmp/rclone3988893505", Modify Window "1s" 2025/12/17 03:43:22 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-jelopox9cuwe" 2025/12/17 03:43:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/17 03:43:22 DEBUG : Setting host="172.17.0.12" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/17 03:43:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/17 03:43:22 DEBUG : Setting pass="Xk7Yb0S-qxPkHAhS2Wfu625XL7R5lQR8z4YWIdO6BD0" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/17 03:43:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/17 03:43:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xkjfW}" suffix to name 2025/12/17 03:43:22 DEBUG : Setting host="172.17.0.12" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/17 03:43:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/17 03:43:22 DEBUG : Setting pass="Xk7Yb0S-qxPkHAhS2Wfu625XL7R5lQR8z4YWIdO6BD0" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/17 03:43:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: Connecting to FTP server 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: dial("tcp","172.17.0.12:21") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: > dial: conn=172.17.0.1:37266->172.17.0.12:21, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:30902") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:60080->172.17.0.12:30902, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:32077") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:45690->172.17.0.12:32077, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:36863") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:60650->172.17.0.12:36863, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:33743") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:38102->172.17.0.12:33743, err= sync_test.go:1736: Server side move (if possible) ftp://172.17.0.12:21/rclone-test-todabup8zogu -> ftp://172.17.0.12:21/rclone-test-jelopox9cuwe 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: dial("tcp","172.17.0.12:32355") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: > dial: conn=172.17.0.1:42098->172.17.0.12:32355, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: dial("tcp","172.17.0.12:31935") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: > dial: conn=172.17.0.1:33084->172.17.0.12:31935, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: dial("tcp","172.17.0.12:34682") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: > dial: conn=172.17.0.1:59268->172.17.0.12:34682, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: Using server-side directory move 2025/12/17 03:43:22 INFO : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: dial("tcp","172.17.0.12:34757") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:30894") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: > dial: conn=172.17.0.1:59014->172.17.0.12:34757, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:36210->172.17.0.12:30894, err= 2025/12/17 03:43:22 DEBUG : potato2: Need to transfer - File not found at Destination 2025/12/17 03:43:22 DEBUG : empty space: size = 1 OK 2025/12/17 03:43:22 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/12/17 03:43:22 DEBUG : empty space: Unchanged skipping 2025/12/17 03:43:22 DEBUG : potato3: size = 68 (ftp://172.17.0.12:21/rclone-test-todabup8zogu) 2025/12/17 03:43:22 DEBUG : potato3: size = 60 (ftp://172.17.0.12:21/rclone-test-jelopox9cuwe) 2025/12/17 03:43:22 DEBUG : potato3: Sizes differ 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: Waiting for checks to finish 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: Connecting to FTP server 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: dial("tcp","172.17.0.12:21") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: > dial: conn=172.17.0.1:37270->172.17.0.12:21, err= 2025/12/17 03:43:22 INFO : empty space: Deleted 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: Waiting for transfers to finish 2025/12/17 03:43:22 INFO : potato3: Deleted 2025/12/17 03:43:22 INFO : potato3: Moved (server-side) 2025/12/17 03:43:22 INFO : potato2: Moved (server-side) 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:34554") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:34070->172.17.0.12:34554, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: dial("tcp","172.17.0.12:37912") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: > dial: conn=172.17.0.1:39262->172.17.0.12:37912, err= 2025/12/17 03:43:22 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-xulewog1juyu" 2025/12/17 03:43:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/17 03:43:22 DEBUG : Setting host="172.17.0.12" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/17 03:43:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/17 03:43:22 DEBUG : Setting pass="Xk7Yb0S-qxPkHAhS2Wfu625XL7R5lQR8z4YWIdO6BD0" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/17 03:43:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/17 03:43:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xkjfW}" suffix to name 2025/12/17 03:43:22 DEBUG : Setting host="172.17.0.12" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/17 03:43:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/17 03:43:22 DEBUG : Setting pass="Xk7Yb0S-qxPkHAhS2Wfu625XL7R5lQR8z4YWIdO6BD0" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/17 03:43:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: Connecting to FTP server 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: dial("tcp","172.17.0.12:21") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: > dial: conn=172.17.0.1:37282->172.17.0.12:21, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: Using server-side directory move 2025/12/17 03:43:22 INFO : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: Server side directory move succeeded 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: dial("tcp","172.17.0.12:35429") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: > dial: conn=172.17.0.1:56150->172.17.0.12:35429, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: dial("tcp","172.17.0.12:31314") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: > dial: conn=172.17.0.1:50098->172.17.0.12:31314, err= 2025/12/17 03:43:22 ERROR : error listing: directory not found 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: dial("tcp","172.17.0.12:35659") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: > dial: conn=172.17.0.1:52136->172.17.0.12:35659, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: Purge object "empty space" 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: Purge object "potato2" 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: Purge object "potato3" 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-xulewog1juyu: Purge dir "" 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: dial("tcp","172.17.0.12:36930") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: > dial: conn=172.17.0.1:59762->172.17.0.12:36930, err= 2025/12/17 03:43:22 ERROR : error listing: directory not found 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-jelopox9cuwe: Purge dir "" 2025/12/17 03:43:22 NOTICE: purge failed to rmdir "": directory not found 2025/12/17 03:43:22 NOTICE: purge failed: directory not found 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:39917") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:43646->172.17.0.12:39917, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:36712") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:52936->172.17.0.12:36712, err= --- PASS: TestServerSideMove (0.09s) === RUN TestServerSideMoveWithFilter run.go:185: Remote "ftp://172.17.0.12:21/rclone-test-todabup8zogu", Local "Local file system at /tmp/rclone3988893505", Modify Window "1s" 2025/12/17 03:43:22 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-hiweqih8jito" 2025/12/17 03:43:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/17 03:43:22 DEBUG : Setting host="172.17.0.12" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/17 03:43:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/17 03:43:22 DEBUG : Setting pass="Xk7Yb0S-qxPkHAhS2Wfu625XL7R5lQR8z4YWIdO6BD0" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/17 03:43:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/17 03:43:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xkjfW}" suffix to name 2025/12/17 03:43:22 DEBUG : Setting host="172.17.0.12" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/17 03:43:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/17 03:43:22 DEBUG : Setting pass="Xk7Yb0S-qxPkHAhS2Wfu625XL7R5lQR8z4YWIdO6BD0" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/17 03:43:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: Connecting to FTP server 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: dial("tcp","172.17.0.12:21") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: > dial: conn=172.17.0.1:37292->172.17.0.12:21, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:39397") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:34860->172.17.0.12:39397, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:36528") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:57134->172.17.0.12:36528, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:36056") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:52736->172.17.0.12:36056, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:39444") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:39830->172.17.0.12:39444, err= sync_test.go:1736: Server side move (if possible) ftp://172.17.0.12:21/rclone-test-todabup8zogu -> ftp://172.17.0.12:21/rclone-test-hiweqih8jito 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: dial("tcp","172.17.0.12:33189") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: > dial: conn=172.17.0.1:47600->172.17.0.12:33189, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: dial("tcp","172.17.0.12:34385") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: > dial: conn=172.17.0.1:46260->172.17.0.12:34385, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: dial("tcp","172.17.0.12:35530") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: > dial: conn=172.17.0.1:50338->172.17.0.12:35530, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: dial("tcp","172.17.0.12:37556") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: > dial: conn=172.17.0.1:47722->172.17.0.12:37556, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:38214") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:58240->172.17.0.12:38214, err= 2025/12/17 03:43:22 DEBUG : empty space: Excluded (Size Filter) 2025/12/17 03:43:22 DEBUG : empty space: Excluded 2025/12/17 03:43:22 DEBUG : empty space: Excluded (Size Filter) 2025/12/17 03:43:22 DEBUG : empty space: Excluded 2025/12/17 03:43:22 DEBUG : potato2: Need to transfer - File not found at Destination 2025/12/17 03:43:22 DEBUG : potato3: size = 68 (ftp://172.17.0.12:21/rclone-test-todabup8zogu) 2025/12/17 03:43:22 DEBUG : potato3: size = 60 (ftp://172.17.0.12:21/rclone-test-hiweqih8jito) 2025/12/17 03:43:22 DEBUG : potato3: Sizes differ 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: Waiting for checks to finish 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: Waiting for transfers to finish 2025/12/17 03:43:22 INFO : potato3: Deleted 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: Connecting to FTP server 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: dial("tcp","172.17.0.12:21") 2025/12/17 03:43:22 INFO : potato3: Moved (server-side) 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: > dial: conn=172.17.0.1:37294->172.17.0.12:21, err= 2025/12/17 03:43:22 INFO : potato2: Moved (server-side) 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:39628") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:57822->172.17.0.12:39628, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: dial("tcp","172.17.0.12:37893") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: > dial: conn=172.17.0.1:39766->172.17.0.12:37893, err= 2025/12/17 03:43:22 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-bibiheh3cahu" 2025/12/17 03:43:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/17 03:43:22 DEBUG : Setting host="172.17.0.12" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/17 03:43:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/17 03:43:22 DEBUG : Setting pass="Xk7Yb0S-qxPkHAhS2Wfu625XL7R5lQR8z4YWIdO6BD0" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/17 03:43:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/17 03:43:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xkjfW}" suffix to name 2025/12/17 03:43:22 DEBUG : Setting host="172.17.0.12" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/17 03:43:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/17 03:43:22 DEBUG : Setting pass="Xk7Yb0S-qxPkHAhS2Wfu625XL7R5lQR8z4YWIdO6BD0" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/17 03:43:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: Connecting to FTP server 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: dial("tcp","172.17.0.12:21") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: > dial: conn=172.17.0.1:37310->172.17.0.12:21, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: dial("tcp","172.17.0.12:30749") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: > dial: conn=172.17.0.1:33734->172.17.0.12:30749, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: dial("tcp","172.17.0.12:33332") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: > dial: conn=172.17.0.1:38964->172.17.0.12:33332, err= 2025/12/17 03:43:22 DEBUG : empty space: Excluded (Size Filter) 2025/12/17 03:43:22 DEBUG : empty space: Excluded 2025/12/17 03:43:22 DEBUG : potato2: Need to transfer - File not found at Destination 2025/12/17 03:43:22 DEBUG : potato3: Need to transfer - File not found at Destination 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: Connecting to FTP server 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: dial("tcp","172.17.0.12:21") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: Waiting for checks to finish 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: Waiting for transfers to finish 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: > dial: conn=172.17.0.1:37326->172.17.0.12:21, err= 2025/12/17 03:43:22 INFO : potato2: Moved (server-side) 2025/12/17 03:43:22 INFO : potato3: Moved (server-side) 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: dial("tcp","172.17.0.12:31841") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: > dial: conn=172.17.0.1:33720->172.17.0.12:31841, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: dial("tcp","172.17.0.12:38119") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: > dial: conn=172.17.0.1:42388->172.17.0.12:38119, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: dial("tcp","172.17.0.12:39147") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: > dial: conn=172.17.0.1:59450->172.17.0.12:39147, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: Purge object "potato2" 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: Purge object "potato3" 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-bibiheh3cahu: Purge dir "" 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: dial("tcp","172.17.0.12:30317") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: > dial: conn=172.17.0.1:35654->172.17.0.12:30317, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: Purge object "empty space" 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-hiweqih8jito: Purge dir "" 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:30048") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:36632->172.17.0.12:30048, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:34759") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:43356->172.17.0.12:34759, err= --- PASS: TestServerSideMoveWithFilter (0.10s) PASS 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: dial("tcp","172.17.0.12:35334") 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: > dial: conn=172.17.0.1:34656->172.17.0.12:35334, err= 2025/12/17 03:43:22 DEBUG : ftp://172.17.0.12:21/rclone-test-todabup8zogu: Purge dir "" "./sync.test -test.v -test.timeout 1h0m0s -remote TestFTPPureftpd: -verbose -test.run '^(TestServerSideMove|TestServerSideMoveWithFilter)$'" - Finished OK in 249.509059ms (try 2/5)