"./gitannex.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose" - Starting (try 1/5)
2025/03/16 05:00:50 DEBUG : Creating backend with remote "TestPikPak:rclone-test-tepajar3buji"
2025/03/16 05:00:50 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/16 05:00:50 DEBUG : TestPikPak: Loaded invalid token from config file - ignoring
2025/03/16 05:00:51 DEBUG : Saving config "token" in section "TestPikPak" of the config file
2025/03/16 05:00:51 DEBUG : TestPikPak: Saved new token in config file
2025/03/16 05:00:52 DEBUG : Saving config "captcha_token" in section "TestPikPak" of the config file
2025/03/16 05:00:54 DEBUG : Creating backend with remote "/tmp/rclone205052093"
=== RUN   TestEndToEnd
    e2e_test.go:189: Skipping because fstest remote was specified.
--- SKIP: TestEndToEnd (0.00s)
=== RUN   TestEndToEndMigration
    e2e_test.go:189: Skipping because fstest remote was specified.
--- SKIP: TestEndToEndMigration (0.00s)
=== RUN   TestEndToEndRepoLayoutCompat
    e2e_test.go:189: Skipping because fstest remote was specified.
--- SKIP: TestEndToEndRepoLayoutCompat (0.00s)
=== RUN   TestFixArgsForSymlinkIdentity
--- PASS: TestFixArgsForSymlinkIdentity (0.00s)
=== RUN   TestFixArgsForSymlinkCorrectName
--- PASS: TestFixArgsForSymlinkCorrectName (0.00s)
=== RUN   TestMessageParser
=== RUN   TestMessageParser/OneParam
=== PAUSE TestMessageParser/OneParam
=== RUN   TestMessageParser/TwoParams
=== PAUSE TestMessageParser/TwoParams
=== RUN   TestMessageParser/TwoParamsNoTrailingNewline
=== PAUSE TestMessageParser/TwoParamsNoTrailingNewline
=== RUN   TestMessageParser/ThreeParamsWhereFinalParamContainsSpaces
=== PAUSE TestMessageParser/ThreeParamsWhereFinalParamContainsSpaces
=== RUN   TestMessageParser/OneLongFinalParameter
=== PAUSE TestMessageParser/OneLongFinalParameter
=== RUN   TestMessageParser/MultipleSpaces
=== PAUSE TestMessageParser/MultipleSpaces
=== RUN   TestMessageParser/StartsWithSpace
=== PAUSE TestMessageParser/StartsWithSpace
=== CONT  TestMessageParser/OneParam
=== CONT  TestMessageParser/OneLongFinalParameter
=== CONT  TestMessageParser/ThreeParamsWhereFinalParamContainsSpaces
=== RUN   TestMessageParser/OneLongFinalParameter/lineEnding
=== CONT  TestMessageParser/TwoParamsNoTrailingNewline
=== CONT  TestMessageParser/StartsWithSpace
=== CONT  TestMessageParser/TwoParams
=== CONT  TestMessageParser/MultipleSpaces
=== RUN   TestMessageParser/OneLongFinalParameter/lineEnding0a
=== RUN   TestMessageParser/OneLongFinalParameter/lineEnding0d
=== RUN   TestMessageParser/OneLongFinalParameter/lineEnding0d0a
=== RUN   TestMessageParser/OneLongFinalParameter/lineEnding0a0d
--- PASS: TestMessageParser (0.00s)
    --- PASS: TestMessageParser/OneParam (0.00s)
    --- PASS: TestMessageParser/ThreeParamsWhereFinalParamContainsSpaces (0.00s)
    --- PASS: TestMessageParser/TwoParamsNoTrailingNewline (0.00s)
    --- PASS: TestMessageParser/TwoParams (0.00s)
    --- PASS: TestMessageParser/StartsWithSpace (0.00s)
    --- PASS: TestMessageParser/MultipleSpaces (0.00s)
    --- PASS: TestMessageParser/OneLongFinalParameter (0.00s)
        --- PASS: TestMessageParser/OneLongFinalParameter/lineEnding (0.00s)
        --- PASS: TestMessageParser/OneLongFinalParameter/lineEnding0a (0.00s)
        --- PASS: TestMessageParser/OneLongFinalParameter/lineEnding0d (0.00s)
        --- PASS: TestMessageParser/OneLongFinalParameter/lineEnding0d0a (0.00s)
        --- PASS: TestMessageParser/OneLongFinalParameter/lineEnding0a0d (0.00s)
=== RUN   TestConfigDefinitionOneName
--- PASS: TestConfigDefinitionOneName (0.00s)
=== RUN   TestConfigDefinitionTwoNames
--- PASS: TestConfigDefinitionTwoNames (0.00s)
=== RUN   TestConfigDefinitionThreeNames
--- PASS: TestConfigDefinitionThreeNames (0.00s)
=== RUN   TestWindowsFilepathRelQuirk
    gitannex_test.go:342: 
--- SKIP: TestWindowsFilepathRelQuirk (0.00s)
=== RUN   TestGitAnnexFstestBackendCases
=== RUN   TestGitAnnexFstestBackendCases/HandlesInit
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:54 ERROR : : error listing: directory not found
2025/03/16 05:00:54 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesListConfigs
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:54 ERROR : : error listing: directory not found
2025/03/16 05:00:55 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesPrepare
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:55 ERROR : : error listing: directory not found
2025/03/16 05:00:55 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesPrepareWithNonexistentRemote
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:56 ERROR : : error listing: directory not found
2025/03/16 05:00:56 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesPrepareWithPathAsRemote
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:56 ERROR : : error listing: directory not found
2025/03/16 05:00:56 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesPrepareWithNonexistentBackendAsRemote
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:57 ERROR : : error listing: directory not found
2025/03/16 05:00:57 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendAsRemote
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:57 ERROR : : error listing: directory not found
2025/03/16 05:00:57 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendMissingTrailingColonAsRemote
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:58 ERROR : : error listing: directory not found
2025/03/16 05:00:58 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendContainingOptionsAsRemote
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:58 ERROR : : error listing: directory not found
2025/03/16 05:00:58 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendContainingOptionsAndIllegalPathAsRemote
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:59 ERROR : : error listing: directory not found
2025/03/16 05:00:59 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesPrepareWithSynonyms
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:00:59 ERROR : : error listing: directory not found
2025/03/16 05:00:59 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesPrepareAndDoesNotTrimWhitespaceFromValue
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:01:00 ERROR : : error listing: directory not found
2025/03/16 05:01:00 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/HandlesEarlyError
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:01:00 ERROR : : error listing: directory not found
2025/03/16 05:01:00 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/ConfigFail
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:01:01 ERROR : : error listing: directory not found
2025/03/16 05:01:01 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/TransferStoreEmptyPath
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:01:01 ERROR : : error listing: directory not found
2025/03/16 05:01:01 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/ExtensionsCompound
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:01:02 ERROR : : error listing: directory not found
2025/03/16 05:01:02 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/ExtensionsIdempotent
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:01:02 ERROR : : error listing: directory not found
2025/03/16 05:01:03 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/ExtensionsSupportsMultiple
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:01:03 ERROR : : error listing: directory not found
2025/03/16 05:01:03 ERROR : : error listing: directory not found
=== RUN   TestGitAnnexFstestBackendCases/TransferStoreAbsolute
    run.go:180: Remote "PikPak root 'rclone-test-tepajar3buji'", Local "Local file system at /tmp/rclone205052093", Modify Window "876000h0m0s"
2025/03/16 05:01:03 DEBUG : Creating backend with remote "TestPikPak:rclone-test-tepajar3buji"
2025/03/16 05:01:04 DEBUG : Creating backend with remote "/tmp/rclone205052093"
2025/03/16 05:01:05 DEBUG : file.txt: Need to transfer - File not found at Destination
2025/03/16 05:01:06 DEBUG : KeyAbsolute: gcid = C1BCFD6877BB358C0518ECCD6D5A70BFF7D0A174
2025/03/16 05:01:07 DEBUG : KeyAbsolute: canceling upload: failed to upload: operation error S3: PutObject, https response error StatusCode: 400, RequestID: 67D65B13058B0F3436C04A72, HostID: vip-lixian-07.mypikpak.com, api error InvalidArgument: aws-chunked encoding is not supported with the specified x-amz-content-sha256 value.
2025/03/16 05:01:08 DEBUG : KeyAbsolute: waiting 500ms for the cancellation to be effective
2025/03/16 05:01:09 ERROR : file.txt: Failed to copy: failed to upload: operation error S3: PutObject, https response error StatusCode: 400, RequestID: 67D65B13058B0F3436C04A72, HostID: vip-lixian-07.mypikpak.com, api error InvalidArgument: aws-chunked encoding is not supported with the specified x-amz-content-sha256 value.
    gitannex_test.go:283: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:283
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:908
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1330
        	Error:      	Not equal: 
        	            	expected: "TRANSFER-SUCCESS STORE KeyAbsolute\n"
        	            	actual  : "TRANSFER-FAILURE STORE KeyAbsolute failed to copy file: failed to upload: operation error S3: PutObject, https response error StatusCode: 400, RequestID: 67D65B13058B0F3436C04A72, HostID: vip-lixian-07.mypikpak.com, api error InvalidArgument: aws-chunked encoding is not supported with the specified x-amz-content-sha256 value.\n"
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,2 +1,2 @@
        	            	-TRANSFER-SUCCESS STORE KeyAbsolute
        	            	+TRANSFER-FAILURE STORE KeyAbsolute failed to copy file: failed to upload: operation error S3: PutObject, https response error StatusCode: 400, RequestID: 67D65B13058B0F3436C04A72, HostID: vip-lixian-07.mypikpak.com, api error InvalidArgument: aws-chunked encoding is not supported with the specified x-amz-content-sha256 value.
        	            	 
        	Test:       	TestGitAnnexFstestBackendCases/TransferStoreAbsolute
    gitannex_test.go:1321: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1321
        	            				/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/asm_amd64.s:1700
        	Error:      	Received unexpected error:
        	            	failed to upload: operation error S3: PutObject, https response error StatusCode: 400, RequestID: 67D65B13058B0F3436C04A72, HostID: vip-lixian-07.mypikpak.com, api error InvalidArgument: aws-chunked encoding is not supported with the specified x-amz-content-sha256 value.
        	Test:       	TestGitAnnexFstestBackendCases/TransferStoreAbsolute
panic: test timed out after 1h0m0s
	running tests:
		TestGitAnnexFstestBackendCases (1h0m0s)
		TestGitAnnexFstestBackendCases/TransferStoreAbsolute (59m51s)

goroutine 546 [running]:
testing.(*M).startAlarm.func1()
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2373 +0x385
created by time.goFunc
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/time/sleep.go:215 +0x2d

goroutine 1 [chan receive, 60 minutes]:
testing.(*T).Run(0xc000782680, {0x267380b?, 0x0?}, 0x27864d8)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1751 +0x3ab
testing.runTests.func1(0xc000782680)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2168 +0x37
testing.tRunner(0xc000782680, 0xc00088bc18)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4
testing.runTests(0xc000545968, {0x3d953a0, 0xb, 0xb}, {0x858cc0?, 0x3df15a8?, 0x3dcdba0?})
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2166 +0x43d
testing.(*M).Run(0xc0007b8140)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2034 +0x64a
github.com/rclone/rclone/fstest.TestMain(0xc0007b8140)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:69 +0xa5
github.com/rclone/rclone/cmd/gitannex.TestMain(...)
	/home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1286
main.main()
	_testmain.go:67 +0xa9

goroutine 15 [syscall, 60 minutes]:
os/signal.signal_recv()
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/sigqueue.go:152 +0x29
os/signal.loop()
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/os/signal/signal_unix.go:23 +0x13
created by os/signal.Notify.func1.1 in goroutine 1
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/os/signal/signal.go:151 +0x1f

goroutine 16 [chan receive, 60 minutes]:
github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27
created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7

goroutine 106 [chan receive, 59 minutes]:
testing.(*T).Run(0xc000168b60, {0x2651e38?, 0xf?}, 0xc0005d05d0)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1751 +0x3ab
github.com/rclone/rclone/cmd/gitannex.TestGitAnnexFstestBackendCases(0xc000168b60)
	/home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1293 +0x67
testing.tRunner(0xc000168b60, 0x27864d8)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4
created by testing.(*T).Run in goroutine 1
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1743 +0x390

goroutine 130 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc000b70a80)
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x13d
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 116
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:404 +0xb6

goroutine 469 [semacquire, 59 minutes]:
sync.runtime_Semacquire(0xc000833b18?)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/sema.go:71 +0x25
sync.(*WaitGroup).Wait(0xc000105880?)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/sync/waitgroup.go:118 +0x48
runtime.Goexit()
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:629 +0x5e
testing.(*common).FailNow(0xc000496820)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1006 +0x4a
github.com/stretchr/testify/require.Equal({0x2a52230, 0xc000496820}, {0x2095ec0, 0xc0005ec3c0}, {0x2095ec0, 0xc0005ec400}, {0x0, 0x0, 0x0})
	/home/rclone/go/pkg/mod/github.com/stretchr/testify@v1.10.0/require/require.go:162 +0xff
github.com/rclone/rclone/cmd/gitannex.(*testState).requireReadLineExact(0xc0000be640, {0x2683106, 0x22})
	/home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:283 +0xc8
github.com/rclone/rclone/cmd/gitannex.init.func27(0xc000496820, 0xc0000be640)
	/home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:908 +0x2be
github.com/rclone/rclone/cmd/gitannex.TestGitAnnexFstestBackendCases.func1(0xc000496820)
	/home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1330 +0x39a
testing.tRunner(0xc000496820, 0xc0005d05d0)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4
created by testing.(*T).Run in goroutine 106
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1743 +0x390

goroutine 531 [chan receive, 59 minutes]:
github.com/rclone/rclone/lib/atexit.Register.func1.1()
	/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:45 +0x29
created by github.com/rclone/rclone/lib/atexit.Register.func1 in goroutine 470
	/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68
"./gitannex.test -test.v -test.timeout 1h0m0s -remote TestPikPak: -verbose" - Finished ERROR in 1h0m3.380590797s (try 1/5): exit status 2: Failed []