"./gitannex.test -test.v -test.timeout 1h0m0s -remote TestFTPVsftpd: -verbose" - Starting (try 4/5) 2025/03/01 10:15:37 DEBUG : Creating backend with remote "TestFTPVsftpd:rclone-test-befucag3vefo" 2025/03/01 10:15:37 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/01 10:15:37 DEBUG : Setting type="ftp" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_TYPE 2025/03/01 10:15:37 DEBUG : Setting host="172.17.0.5" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_HOST 2025/03/01 10:15:37 DEBUG : Setting user="rclone" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_USER 2025/03/01 10:15:37 DEBUG : Setting pass="-bE4QVqAwhNYn9tY6gVD8RY-S1bQc7SwGQkAAIhCrNN9" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_PASS 2025/03/01 10:15:37 DEBUG : Setting writing_mdtm="true" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_WRITING_MDTM 2025/03/01 10:15:37 DEBUG : Setting encoding="Ctl,LeftPeriod,Slash" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_ENCODING 2025/03/01 10:15:37 DEBUG : TestFTPVsftpd: detected overridden config - adding "{MSivy}" suffix to name 2025/03/01 10:15:37 DEBUG : Setting host="172.17.0.5" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_HOST 2025/03/01 10:15:37 DEBUG : Setting user="rclone" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_USER 2025/03/01 10:15:37 DEBUG : Setting pass="-bE4QVqAwhNYn9tY6gVD8RY-S1bQc7SwGQkAAIhCrNN9" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_PASS 2025/03/01 10:15:37 DEBUG : Setting writing_mdtm="true" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_WRITING_MDTM 2025/03/01 10:15:37 DEBUG : Setting encoding="Ctl,LeftPeriod,Slash" for "TestFTPVsftpd" from environment variable RCLONE_CONFIG_TESTFTPVSFTPD_ENCODING 2025/03/01 10:15:37 DEBUG : ftp://172.17.0.5:21/rclone-test-befucag3vefo: Connecting to FTP server 2025/03/01 10:15:37 DEBUG : ftp://172.17.0.5:21/rclone-test-befucag3vefo: dial("tcp","172.17.0.5:21") 2025/03/01 10:15:37 DEBUG : ftp://172.17.0.5:21/rclone-test-befucag3vefo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/01 10:15:37 DEBUG : ftp://172.17.0.5:21/rclone-test-befucag3vefo: dial("tcp","172.17.0.5:21109") 2025/03/01 10:15:37 DEBUG : ftp://172.17.0.5:21/rclone-test-befucag3vefo: > dial: conn=*fshttp.timeoutConn, err= 2025/03/01 10:15:37 DEBUG : Creating backend with remote "/tmp/rclone2286906670" === 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/ThreeParamsWhereFinalParamContainsSpaces === CONT TestMessageParser/StartsWithSpace === CONT TestMessageParser/OneLongFinalParameter === RUN TestMessageParser/OneLongFinalParameter/lineEnding === CONT TestMessageParser/MultipleSpaces === CONT TestMessageParser/TwoParamsNoTrailingNewline === RUN TestMessageParser/OneLongFinalParameter/lineEnding0a === CONT TestMessageParser/TwoParams === 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/StartsWithSpace (0.00s) --- PASS: TestMessageParser/MultipleSpaces (0.00s) --- PASS: TestMessageParser/TwoParamsNoTrailingNewline (0.00s) --- PASS: TestMessageParser/TwoParams (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:344: --- SKIP: TestWindowsFilepathRelQuirk (0.00s) === RUN TestGitAnnexFstestBackendCases === RUN TestGitAnnexFstestBackendCases/HandlesInit run.go:180: Remote "ftp://172.17.0.5:21/rclone-test-befucag3vefo", Local "Local file system at /tmp/rclone2286906670", Modify Window "1s" gitannex_test.go:1207: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1207 /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: remote does not exist: TestFTPVsftpd: Test: TestGitAnnexFstestBackendCases/HandlesInit gitannex_test.go:285: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:285 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:419 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1216 Error: Not equal: expected: "INITREMOTE-SUCCESS\n" actual : "INITREMOTE-FAILURE remote does not exist: TestFTPVsftpd:\n" Diff: --- Expected +++ Actual @@ -1,2 +1,2 @@ -INITREMOTE-SUCCESS +INITREMOTE-FAILURE remote does not exist: TestFTPVsftpd: Test: TestGitAnnexFstestBackendCases/HandlesInit 2025/03/01 10:16:38 DEBUG : ftp://172.17.0.5:21/rclone-test-befucag3vefo: closing 1 unused connections panic: test timed out after 1h0m0s running tests: TestGitAnnexFstestBackendCases (1h0m0s) TestGitAnnexFstestBackendCases/HandlesInit (1h0m0s) goroutine 36 [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(0xc00091c340, {0x2672755?, 0x0?}, 0x2785118) /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(0xc00091c340) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2168 +0x37 testing.tRunner(0xc00091c340, 0xc000887c18) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4 testing.runTests(0xc000013008, {0x3d933a0, 0xb, 0xb}, {0x3dcbae0?, 0x1?, 0x3dcbae0?}) /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(0xc0005a94a0) /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(0xc0005a94a0) /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:1167 main.main() _testmain.go:67 +0xa9 goroutine 23 [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 24 [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 70 [chan receive, 60 minutes]: testing.(*T).Run(0xc0008a0b60, {0x2633148?, 0xf?}, 0xc000022f00) /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(0xc0008a0b60) /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1179 +0x67 testing.tRunner(0xc0008a0b60, 0x2785118) /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 71 [semacquire, 60 minutes]: sync.runtime_Semacquire(0xc000821c78?) /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(0xc00089cc40?) /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(0xc0008a0d00) /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({0x2a50cd0, 0xc0008a0d00}, {0x2094ec0, 0xc00003f380}, {0x2094ec0, 0xc00003f390}, {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(0xc0003a6870, {0x2647364, 0x12}) /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:285 +0xc8 github.com/rclone/rclone/cmd/gitannex.init.func9(0xc0008a0d00, 0xc0003a6870) /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:419 +0xeb github.com/rclone/rclone/cmd/gitannex.TestGitAnnexFstestBackendCases.func1(0xc0008a0d00) /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1216 +0x39a testing.tRunner(0xc0008a0d00, 0xc000022f00) /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 70 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1743 +0x390 "./gitannex.test -test.v -test.timeout 1h0m0s -remote TestFTPVsftpd: -verbose" - Finished ERROR in 1h0m0.149435459s (try 4/5): exit status 2: Failed []