"./operations.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestCopyFileMaxTransfer$'" - Starting (try 2/5)
2025/05/06 04:33:42 DEBUG : Creating backend with remote "TestPikPak:rclone-test-zupujek3gesa"
2025/05/06 04:33:42 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/06 04:33:43 DEBUG : Creating backend with remote "/tmp/rclone2062610857"
=== RUN   TestCopyFileMaxTransfer
    run.go:180: Remote "PikPak root 'rclone-test-zupujek3gesa'", Local "Local file system at /tmp/rclone2062610857", Modify Window "876000h0m0s"
2025/05/06 04:33:43 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination
2025/05/06 04:33:44 DEBUG : TestCopyFileMaxTransfer/file1: gcid = 3823E2B83A3BA8D1137EFC1FE13E3A2E7CFB8D82
2025/05/06 04:33:44 DEBUG : TestCopyFileMaxTransfer/file1: Dst hash empty - aborting Src hash check
2025/05/06 04:33:44 INFO  : TestCopyFileMaxTransfer/file1: Copied (new)
2025/05/06 04:33:45 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination
2025/05/06 04:33:48 DEBUG : pacer: low level retry 1/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:33:48 DEBUG : pacer: Rate limited, increasing sleep to 200ms
2025/05/06 04:33:50 DEBUG : pacer: low level retry 2/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:33:50 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2025/05/06 04:33:52 DEBUG : pacer: low level retry 3/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:33:52 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2025/05/06 04:33:54 DEBUG : pacer: low level retry 4/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:33:54 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2025/05/06 04:33:56 DEBUG : pacer: Reducing sleep to 1.2s
2025/05/06 04:33:56 DEBUG : TestCopyFileMaxTransfer/file2: calculating gcid: <nil>
2025/05/06 04:33:56 DEBUG : TestCopyFileMaxTransfer/file2: gcid = f0e1ffc3c129dea8b6c1466ab44456631e19d07f
2025/05/06 04:33:56 DEBUG : pacer: Reducing sleep to 900ms
2025/05/06 04:33:56 DEBUG : file2: canceling upload: failed to upload: read upload data failed: max transfer limit reached as set by --max-transfer
2025/05/06 04:33:57 DEBUG : pacer: Reducing sleep to 675ms
2025/05/06 04:33:58 DEBUG : pacer: Reducing sleep to 506.25ms
2025/05/06 04:33:59 DEBUG : pacer: Reducing sleep to 379.6875ms
2025/05/06 04:33:59 DEBUG : file2: waiting 500ms for the cancellation to be effective
2025/05/06 04:33:59 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: failed to upload: read upload data failed: max transfer limit reached as set by --max-transfer
2025/05/06 04:34:00 DEBUG : pacer: Reducing sleep to 284.765625ms
2025/05/06 04:34:00 DEBUG : pacer: Reducing sleep to 213.574218ms
2025/05/06 04:34:00 DEBUG : pacer: Reducing sleep to 160.180663ms
2025/05/06 04:34:00 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination
2025/05/06 04:34:00 DEBUG : pacer: Reducing sleep to 120.135497ms
2025/05/06 04:34:01 DEBUG : pacer: Reducing sleep to 100ms
2025/05/06 04:34:01 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination
2025/05/06 04:34:03 DEBUG : pacer: low level retry 1/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:34:03 DEBUG : pacer: Rate limited, increasing sleep to 200ms
2025/05/06 04:34:05 DEBUG : pacer: low level retry 2/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:34:05 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2025/05/06 04:34:08 DEBUG : pacer: low level retry 3/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:34:08 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2025/05/06 04:34:10 DEBUG : pacer: low level retry 4/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:34:10 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2025/05/06 04:34:12 DEBUG : pacer: low level retry 5/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:34:12 DEBUG : pacer: Rate limited, increasing sleep to 2s
2025/05/06 04:34:14 DEBUG : pacer: low level retry 6/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:34:16 DEBUG : pacer: low level retry 7/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:34:19 DEBUG : pacer: low level retry 8/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:34:21 DEBUG : pacer: low level retry 9/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:34:23 DEBUG : pacer: low level retry 10/10 (error Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500))
2025/05/06 04:34:23 DEBUG : TestCopyFileMaxTransfer/file4: calculating gcid: Error "internal server error: Post \"http://idx.shub.mypikpak.com\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" (500)
2025/05/06 04:34:23 DEBUG : TestCopyFileMaxTransfer/file4: gcid = 5f1e9de994d03ce8764c1567955d22728ad650b8
2025/05/06 04:34:23 DEBUG : pacer: Reducing sleep to 1.5s
2025/05/06 04:34:25 DEBUG : file4: canceling upload: failed to upload: operation error S3: PutObject, https response error StatusCode: 400, RequestID: 68199150400584303172C64D, HostID: vip-lixian-07.mypikpak.com, api error InvalidArgument: aws-chunked encoding is not supported with the specified x-amz-content-sha256 value.
2025/05/06 04:34:25 DEBUG : pacer: Reducing sleep to 1.125s
2025/05/06 04:34:27 DEBUG : pacer: Reducing sleep to 843.75ms
2025/05/06 04:34:28 DEBUG : pacer: Reducing sleep to 632.8125ms
2025/05/06 04:34:28 DEBUG : file4: waiting 500ms for the cancellation to be effective
2025/05/06 04:34:28 ERROR : TestCopyFileMaxTransfer/file4: Failed to copy: failed to upload: operation error S3: PutObject, https response error StatusCode: 400, RequestID: 68199150400584303172C64D, HostID: vip-lixian-07.mypikpak.com, api error InvalidArgument: aws-chunked encoding is not supported with the specified x-amz-content-sha256 value.
    copy_test.go:504: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy_test.go:504
        	Error:      	Received unexpected error:
        	            	failed to upload: operation error S3: PutObject, https response error StatusCode: 400, RequestID: 68199150400584303172C64D, HostID: vip-lixian-07.mypikpak.com, api error InvalidArgument: aws-chunked encoding is not supported with the specified x-amz-content-sha256 value.
        	Test:       	TestCopyFileMaxTransfer
2025/05/06 04:34:29 DEBUG : pacer: Reducing sleep to 474.609375ms
2025/05/06 04:34:29 DEBUG : pacer: Reducing sleep to 355.957031ms
2025/05/06 04:34:30 DEBUG : pacer: Reducing sleep to 266.967773ms
2025/05/06 04:34:41 DEBUG : pacer: Reducing sleep to 200.225829ms
2025/05/06 04:34:41 DEBUG : pacer: Reducing sleep to 150.169371ms
2025/05/06 04:34:41 DEBUG : TestCopyFileMaxTransfer: Rmdir: contains trashed file: "file1"
2025/05/06 04:34:41 DEBUG : pacer: Reducing sleep to 112.627028ms
2025/05/06 04:34:42 DEBUG : pacer: Reducing sleep to 100ms
--- FAIL: TestCopyFileMaxTransfer (59.61s)
FAIL
2025/05/06 04:34:42 DEBUG : PikPak root 'rclone-test-zupujek3gesa': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose -test.run '^TestCopyFileMaxTransfer$'" - Finished ERROR in 1m1.654337386s (try 2/5): exit status 1: Failed [TestCopyFileMaxTransfer]