"./sync.test -test.v -test.timeout 1h0m0s -remote TestShade: -verbose -test.run '^(TestSyncConcurrentDelete|TestSyncDeleteDuring)$'" - Starting (try 2/5)
2026/09/09 02:19:47 DEBUG : Creating backend with remote "TestShade:rclone-test-yibakay2cedu"
2026/09/09 02:19:47 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/09/09 02:19:47 DEBUG : Creating new ShadeFS backend with drive: cf193d00-c783-4bab-aa7a-fd84b3700d27
2026/09/09 02:19:47 DEBUG : Creating backend with remote "/tmp/rclone2849134098"
=== RUN   TestSyncDeleteDuring
    run.go:198: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-yibakay2cedu", Local "Local file system at /tmp/rclone2849134098", Modify Window "876000h0m0s"
2026/09/09 02:19:48 DEBUG : potato: multipart upload: starting chunk 0 size 21 offset 0/21
2026/09/09 02:19:50 DEBUG : empty space: multipart upload: starting chunk 0 size 1 offset 0/1
2026/09/09 02:19:51 DEBUG : Waiting for deletions to finish
2026/09/09 02:19:51 DEBUG : potato2: Need to transfer - File not found at Destination
2026/09/09 02:19:51 DEBUG : empty space: size = 1 OK
2026/09/09 02:19:51 DEBUG : empty space: Sizes identical
2026/09/09 02:19:51 DEBUG : empty space: Unchanged skipping
2026/09/09 02:19:51 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-yibakay2cedu: Waiting for checks to finish
2026/09/09 02:19:51 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-yibakay2cedu: Waiting for transfers to finish
2026/09/09 02:19:52 INFO  : potato: Deleted
2026/09/09 02:19:52 DEBUG : potato2: multipart upload: starting chunk 0 size 60 offset 0/60
2026/09/09 02:19:54 DEBUG : potato2: size = 60 OK
2026/09/09 02:19:54 INFO  : potato2: Copied (new)
2026/09/09 02:19:54 DEBUG : pacer: low level retry 1/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:19:54 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/09 02:19:54 DEBUG : pacer: low level retry 2/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:19:54 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/09/09 02:19:54 DEBUG : pacer: low level retry 3/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:19:54 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/09/09 02:19:54 DEBUG : pacer: low level retry 4/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:19:54 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/09/09 02:19:55 DEBUG : pacer: low level retry 5/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:19:55 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/09/09 02:19:55 DEBUG : pacer: low level retry 6/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:19:55 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/09/09 02:19:55 DEBUG : pacer: low level retry 7/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:19:55 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/09/09 02:19:56 DEBUG : pacer: low level retry 8/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:19:56 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/09/09 02:19:57 DEBUG : pacer: Reducing sleep to 1.28s
2026/09/09 02:20:00 DEBUG : pacer: Reducing sleep to 640ms
2026/09/09 02:20:01 DEBUG : pacer: low level retry 1/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:20:01 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/09/09 02:20:01 DEBUG : pacer: low level retry 2/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:20:01 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/09/09 02:20:03 DEBUG : pacer: Reducing sleep to 1.28s
--- PASS: TestSyncDeleteDuring (15.62s)
=== RUN   TestSyncConcurrentDelete
    run.go:198: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-yibakay2cedu", Local "Local file system at /tmp/rclone2849134098", Modify Window "876000h0m0s"
2026/09/09 02:20:06 DEBUG : pacer: Reducing sleep to 640ms
2026/09/09 02:20:06 DEBUG : both0: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:07 DEBUG : pacer: Reducing sleep to 320ms
2026/09/09 02:20:07 DEBUG : pacer: Reducing sleep to 160ms
2026/09/09 02:20:09 DEBUG : pacer: Reducing sleep to 80ms
2026/09/09 02:20:09 DEBUG : pacer: Reducing sleep to 40ms
2026/09/09 02:20:09 DEBUG : only0: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:09 DEBUG : pacer: Reducing sleep to 20ms
2026/09/09 02:20:09 DEBUG : pacer: Reducing sleep to 10ms
2026/09/09 02:20:11 DEBUG : both1: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:13 DEBUG : only1: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:15 DEBUG : both2: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:17 DEBUG : only2: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:19 DEBUG : both3: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:21 DEBUG : only3: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:23 DEBUG : both4: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:25 DEBUG : only4: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:27 DEBUG : both5: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:29 DEBUG : only5: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:31 DEBUG : both6: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:33 DEBUG : only6: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:35 DEBUG : both7: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:37 DEBUG : only7: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:39 DEBUG : both8: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:41 DEBUG : only8: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:43 DEBUG : both9: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:45 DEBUG : only9: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:47 DEBUG : both10: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:49 DEBUG : only10: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:51 DEBUG : both11: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:53 DEBUG : only11: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:55 DEBUG : both12: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:57 DEBUG : only12: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:20:59 DEBUG : both13: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:01 DEBUG : only13: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:04 DEBUG : both14: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:06 DEBUG : only14: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:08 DEBUG : both15: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:10 DEBUG : only15: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:12 DEBUG : both16: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:14 DEBUG : only16: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:16 DEBUG : both17: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:18 DEBUG : only17: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:20 DEBUG : both18: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:22 DEBUG : only18: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:24 DEBUG : both19: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:27 DEBUG : only19: multipart upload: starting chunk 0 size 6 offset 0/6
2026/09/09 02:21:28 DEBUG : both0: size = 6 OK
2026/09/09 02:21:28 DEBUG : both0: Sizes identical
2026/09/09 02:21:28 DEBUG : both0: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both10: size = 6 OK
2026/09/09 02:21:28 DEBUG : both10: Sizes identical
2026/09/09 02:21:28 DEBUG : both10: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both11: size = 6 OK
2026/09/09 02:21:28 DEBUG : both11: Sizes identical
2026/09/09 02:21:28 DEBUG : both11: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both12: size = 6 OK
2026/09/09 02:21:28 DEBUG : both12: Sizes identical
2026/09/09 02:21:28 DEBUG : both12: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both13: size = 6 OK
2026/09/09 02:21:28 DEBUG : both13: Sizes identical
2026/09/09 02:21:28 DEBUG : both13: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both14: size = 6 OK
2026/09/09 02:21:28 DEBUG : both14: Sizes identical
2026/09/09 02:21:28 DEBUG : both14: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both15: size = 6 OK
2026/09/09 02:21:28 DEBUG : both15: Sizes identical
2026/09/09 02:21:28 DEBUG : both15: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both16: size = 6 OK
2026/09/09 02:21:28 DEBUG : both16: Sizes identical
2026/09/09 02:21:28 DEBUG : both16: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both17: size = 6 OK
2026/09/09 02:21:28 DEBUG : both17: Sizes identical
2026/09/09 02:21:28 DEBUG : both17: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both18: size = 6 OK
2026/09/09 02:21:28 DEBUG : both18: Sizes identical
2026/09/09 02:21:28 DEBUG : both18: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both19: size = 6 OK
2026/09/09 02:21:28 DEBUG : both19: Sizes identical
2026/09/09 02:21:28 DEBUG : both19: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both1: size = 6 OK
2026/09/09 02:21:28 DEBUG : both1: Sizes identical
2026/09/09 02:21:28 DEBUG : both1: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both2: size = 6 OK
2026/09/09 02:21:28 DEBUG : both2: Sizes identical
2026/09/09 02:21:28 DEBUG : both3: size = 6 OK
2026/09/09 02:21:28 DEBUG : both3: Sizes identical
2026/09/09 02:21:28 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-yibakay2cedu: Waiting for checks to finish
2026/09/09 02:21:28 DEBUG : both2: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both5: size = 6 OK
2026/09/09 02:21:28 DEBUG : both6: size = 6 OK
2026/09/09 02:21:28 DEBUG : both5: Sizes identical
2026/09/09 02:21:28 DEBUG : both6: Sizes identical
2026/09/09 02:21:28 DEBUG : both4: size = 6 OK
2026/09/09 02:21:28 DEBUG : both4: Sizes identical
2026/09/09 02:21:28 DEBUG : both3: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both7: size = 6 OK
2026/09/09 02:21:28 DEBUG : both7: Sizes identical
2026/09/09 02:21:28 DEBUG : both7: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both8: size = 6 OK
2026/09/09 02:21:28 DEBUG : both8: Sizes identical
2026/09/09 02:21:28 DEBUG : both8: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both9: size = 6 OK
2026/09/09 02:21:28 DEBUG : both9: Sizes identical
2026/09/09 02:21:28 DEBUG : both9: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both5: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both6: Unchanged skipping
2026/09/09 02:21:28 DEBUG : both4: Unchanged skipping
2026/09/09 02:21:28 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-yibakay2cedu: Waiting for transfers to finish
2026/09/09 02:21:28 DEBUG : Waiting for deletions to finish
2026/09/09 02:21:29 INFO  : only2: Deleted
2026/09/09 02:21:29 INFO  : only5: Deleted
2026/09/09 02:21:29 INFO  : only7: Deleted
2026/09/09 02:21:29 INFO  : only11: Deleted
2026/09/09 02:21:29 INFO  : only12: Deleted
2026/09/09 02:21:29 INFO  : only17: Deleted
2026/09/09 02:21:29 INFO  : only6: Deleted
2026/09/09 02:21:29 INFO  : only9: Deleted
2026/09/09 02:21:29 INFO  : only10: Deleted
2026/09/09 02:21:29 INFO  : only0: Deleted
2026/09/09 02:21:29 INFO  : only15: Deleted
2026/09/09 02:21:29 INFO  : only16: Deleted
2026/09/09 02:21:29 INFO  : only18: Deleted
2026/09/09 02:21:29 INFO  : only4: Deleted
2026/09/09 02:21:29 INFO  : only8: Deleted
2026/09/09 02:21:29 INFO  : only13: Deleted
2026/09/09 02:21:29 INFO  : only14: Deleted
2026/09/09 02:21:29 DEBUG : pacer: low level retry 1/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:29 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/09 02:21:29 DEBUG : pacer: Reducing sleep to 10ms
2026/09/09 02:21:29 INFO  : only1: Deleted
2026/09/09 02:21:29 INFO  : only3: Deleted
2026/09/09 02:21:29 DEBUG : pacer: low level retry 2/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:29 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/09 02:21:29 DEBUG : pacer: low level retry 3/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:29 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/09/09 02:21:30 DEBUG : pacer: low level retry 4/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:30 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/09/09 02:21:30 DEBUG : pacer: low level retry 5/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:30 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/09/09 02:21:30 DEBUG : pacer: low level retry 6/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:30 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/09/09 02:21:30 DEBUG : pacer: low level retry 7/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:30 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/09/09 02:21:30 DEBUG : pacer: low level retry 8/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:30 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/09/09 02:21:31 DEBUG : pacer: low level retry 9/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:31 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/09/09 02:21:32 DEBUG : pacer: low level retry 10/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:32 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/09/09 02:21:32 ERROR : only19: Couldn't delete: HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND"
2026/09/09 02:21:32 ERROR : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-yibakay2cedu: not deleting directories as there were IO errors
    sync_test.go:2783: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2783
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2789
        	Error:      	Received unexpected error:
        	            	failed to delete 1 files
        	Test:       	TestSyncConcurrentDelete
        	Messages:   	Sync must not return a error
    sync_test.go:2784: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2784
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2789
        	Error:      	Should be false
        	Test:       	TestSyncConcurrentDelete
        	Messages:   	Low level errors must not have happened
2026/09/09 02:21:35 DEBUG : pacer: Reducing sleep to 2.56s
    fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3
2026/09/09 02:21:40 DEBUG : pacer: Reducing sleep to 1.28s
    fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3
2026/09/09 02:21:43 DEBUG : pacer: Reducing sleep to 640ms
    fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:306: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:351
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2785
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2789
        	            				/usr/local/go/src/runtime/asm_amd64.s:1264
        	Error:      	Should be true
        	Test:       	TestSyncConcurrentDelete
        	Messages:   	listing wrong, want
        	            	  both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6) got
        	            	  both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only19 (6)
    fstest.go:192: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:351
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2785
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2789
        	Error:      	Should be true
        	Test:       	TestSyncConcurrentDelete
        	Messages:   	Unexpected file "only19"
2026/09/09 02:21:47 DEBUG : pacer: Reducing sleep to 320ms
2026/09/09 02:21:47 DEBUG : pacer: Reducing sleep to 160ms
2026/09/09 02:21:48 DEBUG : pacer: Reducing sleep to 80ms
2026/09/09 02:21:48 DEBUG : pacer: Reducing sleep to 40ms
2026/09/09 02:21:48 DEBUG : pacer: Reducing sleep to 20ms
2026/09/09 02:21:48 DEBUG : pacer: Reducing sleep to 10ms
2026/09/09 02:21:51 DEBUG : pacer: low level retry 1/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:51 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/09 02:21:51 DEBUG : pacer: low level retry 2/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:51 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/09/09 02:21:51 DEBUG : pacer: low level retry 3/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:51 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/09/09 02:21:51 DEBUG : pacer: low level retry 4/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:51 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/09/09 02:21:51 DEBUG : pacer: low level retry 5/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:51 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/09/09 02:21:51 DEBUG : pacer: low level retry 6/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:51 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/09/09 02:21:52 DEBUG : pacer: low level retry 7/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/09 02:21:52 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/09/09 02:21:52 DEBUG : pacer: Reducing sleep to 640ms
--- FAIL: TestSyncConcurrentDelete (109.59s)
FAIL
2026/09/09 02:21:54 DEBUG : pacer: Reducing sleep to 320ms
2026/09/09 02:21:54 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-yibakay2cedu: Purge dir ""
2026/09/09 02:21:54 DEBUG : pacer: Reducing sleep to 160ms
2026/09/09 02:21:55 DEBUG : pacer: Reducing sleep to 80ms
"./sync.test -test.v -test.timeout 1h0m0s -remote TestShade: -verbose -test.run '^(TestSyncConcurrentDelete|TestSyncDeleteDuring)$'" - Finished ERROR in 2m7.802941374s (try 2/5): exit status 1: Failed [TestSyncConcurrentDelete]