"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter)$'" - Starting (try 2/5) 2025/01/30 02:45:09 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zehuyan0paqi" 2025/01/30 02:45:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/30 02:45:09 DEBUG : Creating backend with remote "TestYandex:rclone-test-zehuyan0paqi" 2025/01/30 02:45:09 DEBUG : Reset feature "ListR" 2025/01/30 02:45:09 DEBUG : Creating backend with remote "/tmp/rclone1224303907" === RUN TestServerSideMoveWithFilter run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-zehuyan0paqi'", Local "Local file system at /tmp/rclone1224303907", Modify Window "1ns" 2025/01/30 02:45:09 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-vazoqav1lepa" 2025/01/30 02:45:09 DEBUG : Creating backend with remote "TestYandex:rclone-test-vazoqav1lepa" 2025/01/30 02:45:10 DEBUG : Reset feature "ListR" 2025/01/30 02:45:17 INFO : potato2.rclone_chunk.001_vx8cg8: Moved (server-side) to: potato2.rclone_chunk.001 2025/01/30 02:45:19 INFO : potato2.rclone_chunk.002_vx8cg8: Moved (server-side) to: potato2.rclone_chunk.002 2025/01/30 02:45:26 INFO : empty space.rclone_chunk.001_vx8oaw: Moved (server-side) to: empty space 2025/01/30 02:45:32 INFO : potato3.rclone_chunk.001_vx8s8n: Moved (server-side) to: potato3.rclone_chunk.001 2025/01/30 02:45:34 INFO : potato3.rclone_chunk.002_vx8s8n: Moved (server-side) to: potato3.rclone_chunk.002 sync_test.go:1705: Server side move (if possible) Chunked 'TestChunkerChunk50bYandex:rclone-test-zehuyan0paqi' -> Chunked 'TestChunkerChunk50bYandex:rclone-test-vazoqav1lepa' 2025/01/30 02:45:42 INFO : empty space.rclone_chunk.001_vx94jh: Moved (server-side) to: empty space 2025/01/30 02:45:52 INFO : potato3.rclone_chunk.001_vx99go: Moved (server-side) to: potato3.rclone_chunk.001 2025/01/30 02:45:53 INFO : potato3.rclone_chunk.002_vx99go: Moved (server-side) to: potato3.rclone_chunk.002 2025/01/30 02:45:57 DEBUG : empty space: Excluded (Size Filter) 2025/01/30 02:45:57 DEBUG : empty space: Excluded 2025/01/30 02:45:57 DEBUG : empty space: Excluded (Size Filter) 2025/01/30 02:45:57 DEBUG : empty space: Excluded 2025/01/30 02:45:57 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/30 02:45:57 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/01/30 02:45:57 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-vazoqav1lepa': Waiting for checks to finish 2025/01/30 02:45:57 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-vazoqav1lepa': Waiting for transfers to finish 2025/01/30 02:45:57 DEBUG : potato2: move 2 data chunks... 2025/01/30 02:45:59 INFO : potato2.rclone_chunk.001: Moved (server-side) 2025/01/30 02:46:01 INFO : potato2.rclone_chunk.002: Moved (server-side) 2025/01/30 02:46:03 INFO : potato2: Moved (server-side) 2025/01/30 02:46:05 INFO : potato2: Moved (server-side) 2025/01/30 02:46:07 INFO : potato3: Deleted 2025/01/30 02:46:07 DEBUG : potato3: move 2 data chunks... 2025/01/30 02:46:09 INFO : potato3.rclone_chunk.001: Moved (server-side) 2025/01/30 02:46:10 INFO : potato3.rclone_chunk.002: Moved (server-side) 2025/01/30 02:46:12 INFO : potato3: Moved (server-side) 2025/01/30 02:46:14 INFO : potato3: Moved (server-side) 2025/01/30 02:46:16 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-civulub7diya" 2025/01/30 02:46:16 DEBUG : Config file has changed externally - reloading 2025/01/30 02:46:16 DEBUG : Creating backend with remote "TestYandex:rclone-test-civulub7diya" 2025/01/30 02:46:16 DEBUG : Reset feature "ListR" 2025/01/30 02:46:16 DEBUG : empty space: Excluded (Size Filter) 2025/01/30 02:46:16 DEBUG : empty space: Excluded 2025/01/30 02:46:16 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/30 02:46:16 DEBUG : potato3: Need to transfer - File not found at Destination 2025/01/30 02:46:16 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-civulub7diya': Waiting for checks to finish 2025/01/30 02:46:16 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-civulub7diya': Waiting for transfers to finish 2025/01/30 02:46:17 DEBUG : potato2: move 2 data chunks... 2025/01/30 02:46:17 DEBUG : potato3: move 2 data chunks... 2025/01/30 02:46:18 INFO : potato2.rclone_chunk.001: Moved (server-side) 2025/01/30 02:46:19 INFO : potato3.rclone_chunk.001: Moved (server-side) 2025/01/30 02:46:20 INFO : potato2.rclone_chunk.002: Moved (server-side) 2025/01/30 02:46:20 INFO : potato3.rclone_chunk.002: Moved (server-side) 2025/01/30 02:46:21 INFO : potato3: Moved (server-side) 2025/01/30 02:46:21 INFO : potato2: Moved (server-side) 2025/01/30 02:46:23 INFO : potato3: Moved (server-side) 2025/01/30 02:46:23 INFO : potato2: Moved (server-side) 2025/01/30 02:46:25 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-civulub7diya': Purge remote 2025/01/30 02:46:32 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-vazoqav1lepa': Purge remote --- PASS: TestServerSideMoveWithFilter (92.33s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-zehuyan0paqi'", Local "Local file system at /tmp/rclone1224303907", Modify Window "1ns" 2025/01/30 02:46:42 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-hegizov7yewi" 2025/01/30 02:46:42 DEBUG : Creating backend with remote "TestYandex:rclone-test-hegizov7yewi" 2025/01/30 02:46:42 DEBUG : Reset feature "ListR" 2025/01/30 02:46:50 INFO : potato2.rclone_chunk.001_vxaws7: Moved (server-side) to: potato2.rclone_chunk.001 2025/01/30 02:46:51 INFO : potato2.rclone_chunk.002_vxaws7: Moved (server-side) to: potato2.rclone_chunk.002 2025/01/30 02:46:58 INFO : empty space.rclone_chunk.001_vxb8ji: Moved (server-side) to: empty space 2025/01/30 02:47:04 INFO : potato3.rclone_chunk.001_vxbcev: Moved (server-side) to: potato3.rclone_chunk.001 2025/01/30 02:47:05 INFO : potato3.rclone_chunk.002_vxbcev: Moved (server-side) to: potato3.rclone_chunk.002 2025/01/30 02:47:08 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Chunked 'TestChunkerChunk50bYandex:rclone-test-zehuyan0paqi' -> Chunked 'TestChunkerChunk50bYandex:rclone-test-hegizov7yewi' 2025/01/30 02:47:14 INFO : empty space.rclone_chunk.001_vxbo2c: Moved (server-side) to: empty space 2025/01/30 02:47:20 INFO : potato3.rclone_chunk.001_vxbsps: Moved (server-side) to: potato3.rclone_chunk.001 2025/01/30 02:47:22 INFO : potato3.rclone_chunk.002_vxbsps: Moved (server-side) to: potato3.rclone_chunk.002 2025/01/30 02:47:24 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-hegizov7yewi': Using server-side directory move 2025/01/30 02:47:24 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-hegizov7yewi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/01/30 02:47:25 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/30 02:47:25 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/01/30 02:47:25 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/30 02:47:25 DEBUG : empty space: Unchanged skipping 2025/01/30 02:47:25 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-hegizov7yewi': Waiting for checks to finish 2025/01/30 02:47:25 DEBUG : potato2: move 2 data chunks... 2025/01/30 02:47:27 INFO : potato2.rclone_chunk.001: Moved (server-side) 2025/01/30 02:47:28 INFO : empty space: Deleted 2025/01/30 02:47:28 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-hegizov7yewi': Waiting for transfers to finish 2025/01/30 02:47:28 INFO : potato2.rclone_chunk.002: Moved (server-side) 2025/01/30 02:47:30 INFO : potato2: Moved (server-side) 2025/01/30 02:47:32 INFO : potato2: Moved (server-side) 2025/01/30 02:47:34 INFO : potato3: Deleted 2025/01/30 02:47:35 DEBUG : potato3: move 2 data chunks... 2025/01/30 02:47:36 INFO : potato3.rclone_chunk.001: Moved (server-side) 2025/01/30 02:47:37 INFO : potato3.rclone_chunk.002: Moved (server-side) 2025/01/30 02:47:39 INFO : potato3: Moved (server-side) 2025/01/30 02:47:41 INFO : potato3: Moved (server-side) 2025/01/30 02:47:41 INFO : tomatoDir: Removing directory 2025/01/30 02:47:45 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zehuyan0paqi': deleted 1 directories 2025/01/30 02:47:47 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-xeyuyun4qivu" 2025/01/30 02:47:47 DEBUG : Creating backend with remote "TestYandex:rclone-test-xeyuyun4qivu" 2025/01/30 02:47:47 DEBUG : Reset feature "ListR" 2025/01/30 02:47:47 INFO : tomatoDir: Making directory 2025/01/30 02:47:48 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-xeyuyun4qivu': Using server-side directory move 2025/01/30 02:47:52 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-xeyuyun4qivu': Server side directory move succeeded 2025/01/30 02:47:54 ERROR : : error listing: directory not found 2025/01/30 02:47:54 ERROR : : error listing: directory not found 2025/01/30 02:47:54 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-xeyuyun4qivu': Purge remote 2025/01/30 02:48:03 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-hegizov7yewi': Purge remote 2025/01/30 02:48:03 NOTICE: purge failed: [404 - DiskNotFoundError] Resource not found. (Не удалось найти запрошенный ресурс.) --- PASS: TestServerSideMoveDeleteEmptySourceDirs (82.66s) PASS 2025/01/30 02:48:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zehuyan0paqi': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter)$'" - Finished OK in 2m59.058011038s (try 2/5)