"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list -test.run '^TestServerSideMoveWithFilter$'" - Starting (try 3/5)
2025/04/30 01:56:28 DEBUG : Creating backend with remote "TestB2:rclone-test-biropal2tuyo"
2025/04/30 01:56:28 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/30 01:56:28 DEBUG : Creating backend with remote "/tmp/rclone3044348813"
=== RUN   TestServerSideMoveWithFilter
    run.go:180: Remote "B2 bucket rclone-test-biropal2tuyo", Local "Local file system at /tmp/rclone3044348813", Modify Window "1ms"
2025/04/30 01:56:28 DEBUG : Creating backend with remote "TestB2:rclone-test-lulomoy3tabe"
    sync_test.go:1705: Server side move (if possible) B2 bucket rclone-test-biropal2tuyo -> B2 bucket rclone-test-lulomoy3tabe
2025/04/30 01:56:34 DEBUG : empty space: Excluded (Size Filter)
2025/04/30 01:56:34 DEBUG : empty space: Excluded (Size Filter)
2025/04/30 01:56:34 DEBUG : potato2: Need to transfer - File not found at Destination
2025/04/30 01:56:34 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2025/04/30 01:56:34 DEBUG : B2 bucket rclone-test-lulomoy3tabe: Waiting for checks to finish
2025/04/30 01:56:34 DEBUG : B2 bucket rclone-test-lulomoy3tabe: Waiting for transfers to finish
2025/04/30 01:56:35 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2025/04/30 01:56:35 INFO  : potato2: Copied (server-side copy)
2025/04/30 01:56:35 INFO  : potato2: Deleted
2025/04/30 01:56:35 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK
2025/04/30 01:56:35 INFO  : potato3: Copied (server-side copy)
2025/04/30 01:56:35 INFO  : potato3: Deleted
2025/04/30 01:56:35 DEBUG : Creating backend with remote "TestB2:rclone-test-labexod2tire"
2025/04/30 01:56:36 DEBUG : empty space: Excluded (Size Filter)
2025/04/30 01:56:37 DEBUG : potato2: Need to transfer - File not found at Destination
2025/04/30 01:56:37 DEBUG : potato3: Need to transfer - File not found at Destination
2025/04/30 01:56:37 DEBUG : B2 bucket rclone-test-labexod2tire: Waiting for checks to finish
2025/04/30 01:56:37 DEBUG : B2 bucket rclone-test-labexod2tire: Waiting for transfers to finish
2025/04/30 01:56:37 DEBUG : potato2: sha1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK
2025/04/30 01:56:37 INFO  : potato2: Copied (server-side copy)
2025/04/30 01:56:37 INFO  : potato2: Deleted
2025/04/30 01:56:38 DEBUG : potato3: sha1 = 568f8850f3c1a384731dbe40c6d72e1dcae342a0 OK
2025/04/30 01:56:38 INFO  : potato3: Copied (server-side copy)
2025/04/30 01:56:38 INFO  : potato3: Deleted
2025/04/30 01:56:38 DEBUG : B2 bucket rclone-test-labexod2tire: Purge remote
2025/04/30 01:56:38 INFO  : B2 bucket rclone-test-labexod2tire: cleaning bucket "rclone-test-labexod2tire" of all files
2025/04/30 01:56:38 DEBUG : potato2: Deleting (id "4_zbf620d43609d8b4b9f680e1b_f113f8052e81e6b18_d20250430_m015637_c001_v0001137_t0008_u01745978197613")
2025/04/30 01:56:38 DEBUG : potato3: Deleting (id "4_zbf620d43609d8b4b9f680e1b_f1099e197dc002d7f_d20250430_m015637_c001_v0001182_t0027_u01745978197945")
2025/04/30 01:56:40 DEBUG : B2 bucket rclone-test-lulomoy3tabe: Purge remote
2025/04/30 01:56:40 INFO  : B2 bucket rclone-test-lulomoy3tabe: cleaning bucket "rclone-test-lulomoy3tabe" of all files
2025/04/30 01:56:40 DEBUG : empty space: Deleting (id "4_zcf32fd33608d8b4b9f680e1b_f1038a5797283c4a6_d20250430_m015633_c001_v0001178_t0003_u01745978193850")
2025/04/30 01:56:40 DEBUG : potato2: Deleting (id "4_zcf32fd33608d8b4b9f680e1b_f4165a94c05d5cf19_d20250430_m015637_c001_v7007000_t0000_u01745978197904")
2025/04/30 01:56:40 DEBUG : potato2: Deleting (id "4_zcf32fd33608d8b4b9f680e1b_f1178a2440a44d660_d20250430_m015634_c001_v0001093_t0008_u01745978194665")
2025/04/30 01:56:40 DEBUG : potato3: Deleting (id "4_zcf32fd33608d8b4b9f680e1b_f4165a94c05d5cf1c_d20250430_m015638_c001_v7007000_t0000_u01745978198162")
2025/04/30 01:56:40 DEBUG : potato3: Deleting (id "4_zcf32fd33608d8b4b9f680e1b_f10028ead16f337bd_d20250430_m015635_c001_v0001146_t0018_u01745978195051")
2025/04/30 01:56:40 DEBUG : potato3: Deleting (id "4_zcf32fd33608d8b4b9f680e1b_f1038a5797283c4a8_d20250430_m015634_c001_v0001178_t0042_u01745978194061")
--- PASS: TestServerSideMoveWithFilter (13.72s)
PASS
2025/04/30 01:56:42 DEBUG : B2 bucket rclone-test-biropal2tuyo: Purge remote
2025/04/30 01:56:42 INFO  : B2 bucket rclone-test-biropal2tuyo: cleaning bucket "rclone-test-biropal2tuyo" of all files
2025/04/30 01:56:42 DEBUG : empty space: Deleting (id "4_z7f32ed83608d8b4b9f680e1b_f408d5495824a0a70_d20250430_m015642_c001_v7007000_t0000_u01745978202317")
2025/04/30 01:56:42 DEBUG : empty space: Deleting (id "4_z7f32ed83608d8b4b9f680e1b_f1034d1b5b451e151_d20250430_m015631_c001_v0001091_t0050_u01745978191468")
2025/04/30 01:56:42 DEBUG : potato2: Deleting (id "4_z7f32ed83608d8b4b9f680e1b_f409b3212cf74a647_d20250430_m015635_c001_v7007000_t0000_u01745978195092")
2025/04/30 01:56:42 DEBUG : potato2: Deleting (id "4_z7f32ed83608d8b4b9f680e1b_f1034d1b5b451e14f_d20250430_m015630_c001_v0001091_t0035_u01745978190909")
2025/04/30 01:56:42 DEBUG : potato3: Deleting (id "4_z7f32ed83608d8b4b9f680e1b_f409b3212cf74a648_d20250430_m015635_c001_v7007000_t0000_u01745978195476")
2025/04/30 01:56:42 DEBUG : potato3: Deleting (id "4_z7f32ed83608d8b4b9f680e1b_f1034d1b5b451e155_d20250430_m015631_c001_v0001091_t0031_u01745978191892")
"./sync.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose -fast-list -test.run '^TestServerSideMoveWithFilter$'" - Finished OK in 15.585300055s (try 3/5)