"./operations.test -test.v -test.timeout 1h0m0s -remote TestShade: -verbose -test.run '^TestMaxDelete$'" - Starting (try 2/5)
2026/09/24 03:20:15 DEBUG : Creating backend with remote "TestShade:rclone-test-zaxohiv5yuxu"
2026/09/24 03:20:15 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/09/24 03:20:15 DEBUG : Creating new ShadeFS backend with drive: cf193d00-c783-4bab-aa7a-fd84b3700d27
2026/09/24 03:20:15 DEBUG : Creating backend with remote "/tmp/rclone3026194830"
=== RUN   TestMaxDelete
    run.go:198: Remote "Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-zaxohiv5yuxu", Local "Local file system at /tmp/rclone3026194830", Modify Window "876000h0m0s"
2026/09/24 03:20:15 DEBUG : small: multipart upload: starting chunk 0 size 10 offset 0/10
2026/09/24 03:20:18 DEBUG : medium: multipart upload: starting chunk 0 size 60 offset 0/60
2026/09/24 03:20:20 DEBUG : large: multipart upload: starting chunk 0 size 100 offset 0/100
2026/09/24 03:20:21 DEBUG : Waiting for deletions to finish
2026/09/24 03:20:21 ERROR : small: Got fatal error on delete: --max-delete threshold reached
2026/09/24 03:20:22 DEBUG : pacer: low level retry 1/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:22 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/24 03:20:22 DEBUG : pacer: Reducing sleep to 10ms
2026/09/24 03:20:22 INFO  : medium: Deleted
2026/09/24 03:20:22 DEBUG : pacer: low level retry 2/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:22 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/09/24 03:20:22 DEBUG : pacer: low level retry 3/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:22 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/09/24 03:20:22 DEBUG : pacer: low level retry 4/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:22 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/09/24 03:20:22 DEBUG : pacer: low level retry 5/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:22 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/09/24 03:20:22 DEBUG : pacer: low level retry 6/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:22 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/09/24 03:20:22 DEBUG : pacer: low level retry 7/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:22 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/09/24 03:20:23 DEBUG : pacer: low level retry 8/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:23 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/09/24 03:20:23 DEBUG : pacer: low level retry 9/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:23 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/09/24 03:20:25 DEBUG : pacer: low level retry 10/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:25 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/09/24 03:20:25 ERROR : large: Couldn't delete: HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND"
2026/09/24 03:20:27 DEBUG : pacer: Reducing sleep to 2.56s
    operations_test.go:484: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:484
        	Error:      	Not equal: 
        	            	expected: 1
        	            	actual  : 2
        	Test:       	TestMaxDelete
2026/09/24 03:20:32 DEBUG : pacer: Reducing sleep to 1.28s
2026/09/24 03:20:35 DEBUG : pacer: Reducing sleep to 640ms
2026/09/24 03:20:36 DEBUG : pacer: Reducing sleep to 320ms
2026/09/24 03:20:37 DEBUG : pacer: low level retry 1/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:37 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/09/24 03:20:37 DEBUG : pacer: low level retry 2/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:37 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/09/24 03:20:38 DEBUG : pacer: low level retry 3/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:38 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/09/24 03:20:39 DEBUG : pacer: low level retry 4/10 (error HTTP error 500 (500 Internal Server Error) returned body: "ENTRY_NOT_FOUND")
2026/09/24 03:20:39 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/09/24 03:20:42 DEBUG : pacer: Reducing sleep to 2.56s
2026/09/24 03:20:47 DEBUG : pacer: Reducing sleep to 1.28s
2026/09/24 03:20:49 DEBUG : pacer: Reducing sleep to 640ms
--- FAIL: TestMaxDelete (34.42s)
FAIL
2026/09/24 03:20:51 DEBUG : pacer: Reducing sleep to 320ms
2026/09/24 03:20:51 DEBUG : Shade drive cf193d00-c783-4bab-aa7a-fd84b3700d27 path rclone-test-zaxohiv5yuxu: Purge dir ""
2026/09/24 03:20:51 DEBUG : pacer: Reducing sleep to 160ms
2026/09/24 03:20:52 DEBUG : pacer: Reducing sleep to 80ms
"./operations.test -test.v -test.timeout 1h0m0s -remote TestShade: -verbose -test.run '^TestMaxDelete$'" - Finished ERROR in 36.906897205s (try 2/5): exit status 1: Failed [TestMaxDelete]