Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

meta: intermittent unexpected disconnect while reading sideband packet when fetching golang.org/x repos since 2022-03-25 #52490

Open
bcmills opened this issue Apr 22, 2022 · 56 comments
Open

meta: intermittent unexpected disconnect while reading sideband packet when fetching golang.org/x repos since 2022-03-25 #52490

bcmills opened this issue Apr 22, 2022 · 56 comments
Labels
NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one.
Milestone
Unreleased

Comments

@bcmills
Copy link
Contributor

bcmills commented Apr 22, 2022 •
edited
Loading 

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`

            	golang.org/x/sys/cpu: golang.org/x/[email protected]: invalid version: git fetch -f origin refs/heads/*:refs/heads/* refs/tags/*:refs/tags/* in $WORK/gopath/pkg/mod/cache/vcs/da0444fc0003f84a590bd6521553c0531086778bca13ec63ace9e0dd258f4b51: exit status 128:
            	error: 46048 bytes of body are still expected
            	fetch-pack: unexpected disconnect while reading sideband packet
            	fatal: early EOF
            	fatal: index-pack failed

greplogs --dashboard -md -l -e 'unexpected disconnect while reading sideband packet'

2022-04-21T16:18:44-b941a10/linux-amd64-longtest
2022-04-11T16:31:42-910a33a/linux-amd64-longtest
2022-04-11T16:31:40-6130b88/linux-386-longtest
2022-03-25T18:19:09-f25631b/linux-386-longtest

Since I assume we haven't recently changed the git version on the builders, this looks to me like either a networking issue on the builders or a regression in the Git server that hosts go.googlesource.com. @golang/release: could you investigate and/or escalate appropriately?
@bcmills
Copy link
Contributor Author

bcmills commented Apr 22, 2022

(Internally this appears to be related to b/190501760.)

@bcmills bcmills added this to the Unreleased milestone Apr 22, 2022
@bcmills bcmills added the NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one. label Apr 22, 2022
@bcmills
Copy link
Contributor Author

bcmills commented May 4, 2022

greplogs -l -e 'unexpected disconnect while reading sideband packet' --since=2022-04-22
2022-05-04T03:08:40-4f89884/linux-386-longtest
2022-04-28T15:11:42-4d35071/linux-amd64-longtest

@bcmills bcmills mentioned this issue May 4, 2022
Closed
@bcmills
Copy link
Contributor Author

bcmills commented May 4, 2022

Filed internally as b/231436415.

@bcmills bcmills mentioned this issue May 6, 2022
Closed
@bcmills
Copy link
Contributor Author

bcmills commented May 10, 2022

greplogs -l -e 'unexpected disconnect while reading sideband packet' --since=2022-05-05
2022-05-09T16:02:28-9ae7dc3/linux-386-longtest

@gopherbot
Copy link
Contributor

Change https://go.dev/cl/405714 mentions this issue: cmd/go: add timestamps to script test output

gopherbot pushed a commit that referenced this issue May 11, 2022
@gopherbot
cmd/go: add timestamps to script test output
d339d08 
Go tests don't include timestamps by default, but we would like to
have them in order to correlate builder failures with server and
network logs.

Since many of the Go tests with external network and service
dependencies are script tests for the 'go' command, logging timestamps
here adds a lot of logging value with one simple and very low-risk
change.

For #50541.
For #52490.
For #52545.
For #52851.

Change-Id: If3fa86deb4a216ec6a1abc4e6f4ee9b05030a729
Reviewed-on: https://go-review.googlesource.com/c/go/+/405714
Reviewed-by: Dmitri Shuralyov <[email protected]>
Auto-Submit: Bryan Mills <[email protected]>
Reviewed-by: Dmitri Shuralyov <[email protected]>
TryBot-Result: Gopher Robot <[email protected]>
Run-TryBot: Bryan Mills <[email protected]>
@bcmills bcmills added the WaitingForInfo Issue is not actionable because of missing required information, which needs to be provided. label May 16, 2022
@bcmills
Copy link
Contributor Author

bcmills commented May 16, 2022

No recurrences so far since the timestamping was added:

greplogs -l -e 'unexpected disconnect while reading sideband packet' --since=2022-05-10

(0 matching logs)

@bcmills bcmills mentioned this issue Jul 28, 2022
Closed
@bcmills bcmills mentioned this issue Sep 28, 2022
Closed
@bcmills bcmills moved this to Active in Test Flakes Sep 28, 2022
@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2022-09-27 21:00 linux-amd64-longtest go@871a3a40 cmd/go.TestScript (log) 
go test proxy running at GOPROXY=http://127.0.0.1:46033/mod
--- FAIL: TestScript (0.01s)
    --- FAIL: TestScript/mod_replace_gopkgin (33.32s)
        script_test.go:282: 
            # (2022-09-27T21:29:37Z)
            # Regression test for golang.org/issue/34254:
            # a clone of gopkg.in/[…].vN should be replaceable by
            # a fork hosted at corp.example.com/[…]/vN,
            # even if there is an explicit go.mod file containing the
            # gopkg.in path. (0.000s)
...
            	21:29:44.841637 http.c:715              <= Recv header: date: Tue, 27 Sep 2022 21:29:44 GMT
            	21:29:44.841641 http.c:703              <= Recv header, 0000000002 bytes (0x00000002)
            	21:29:44.841645 http.c:715              <= Recv header:
            	21:30:06.089255 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            	error: 10224 bytes of body are still expected
            	fetch-pack: unexpected disconnect while reading sideband packet
            	fatal: early EOF
            	fatal: index-pack failed
            [exit status 1]
            FAIL: testdata/script/mod_replace_gopkgin.txt:20: unexpected command failure

— watchflakes

@joedian joedian removed the WaitingForInfo Issue is not actionable because of missing required information, which needs to be provided. label Oct 10, 2022
@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2022-11-28 16:53 linux-amd64-longtest-race go@9f0ffc93 cmd/go/internal/modfetch.TestCodeRepo (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:44035
https://vcs-test.golang.org rerouted to https://127.0.0.1:44405
--- FAIL: TestCodeRepo (0.00s)
    --- FAIL: TestCodeRepo/golang.org_x_text/4e4a3210bb (22.77s)
        coderepo_test.go:633: repo.Stat("4e4a3210bb"): golang.org/x/text@4e4a3210bb: invalid version: git fetch -f origin refs/heads/*:refs/heads/* refs/tags/*:refs/tags/* in /workdir/tmp/gitrepo-test-1764289710/modcache/cache/vcs/38515699458adac9c8b61a0b44f9ad7a5f6edd7bcc2d7fae95930ec78f71e1b4: exit status 128:
            	error: 65184 bytes of body are still expected
            	fetch-pack: unexpected disconnect while reading sideband packet
            	fatal: early EOF
            	fatal: index-pack failed
2022-12-01 21:01 linux-amd64-longtest-race go@c71d3a0f cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:46087
https://vcs-test.golang.org rerouted to https://127.0.0.1:34889
go test proxy running at GOPROXY=http://127.0.0.1:44813/mod
2022/12/01 21:59:45 http: TLS handshake error from 127.0.0.1:38608: EOF
2022/12/01 22:00:11 http: TLS handshake error from 127.0.0.1:59702: EOF
2022/12/01 22:00:11 http: TLS handshake error from 127.0.0.1:59708: EOF
2022/12/01 22:00:11 http: TLS handshake error from 127.0.0.1:59718: EOF
--- FAIL: TestScript (0.15s)
    --- FAIL: TestScript/mod_replace_gopkgin (36.30s)
        script_test.go:134: 2022-12-01T21:59:42Z
...
            	21:59:49.906634 http.c:703              <= Recv header, 0000000037 bytes (0x00000025)
            	21:59:49.906639 http.c:715              <= Recv header: date: Thu, 01 Dec 2022 21:59:49 GMT
            	21:59:49.906644 http.c:703              <= Recv header, 0000000002 bytes (0x00000002)
            	21:59:49.906647 http.c:715              <= Recv header:
            	22:00:13.086902 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            	error: 6640 bytes of body are still expected
            	fetch-pack: unexpected disconnect while reading sideband packet
            	fatal: early EOF
            	fatal: index-pack failed
        script_test.go:154: FAIL: mod_replace_gopkgin.txt:20: go list -m gopkg.in/src-d/go-git.v4: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2022-12-14 22:29 linux-386-longtest go@ea14d1b6 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:39895
https://vcs-test.golang.org rerouted to https://127.0.0.1:45129
go test proxy running at GOPROXY=http://127.0.0.1:45137/mod
2022/12/14 23:12:28 http: TLS handshake error from 127.0.0.1:41306: EOF
2022/12/14 23:12:47 http: TLS handshake error from 127.0.0.1:34714: EOF
2022/12/14 23:12:47 http: TLS handshake error from 127.0.0.1:34690: EOF
2022/12/14 23:12:47 http: TLS handshake error from 127.0.0.1:34706: EOF
2022/12/14 23:12:47 http: TLS handshake error from 127.0.0.1:34752: EOF
2022/12/14 23:12:47 http: TLS handshake error from 127.0.0.1:34736: EOF
2022/12/14 23:12:47 http: TLS handshake error from 127.0.0.1:34726: EOF
...
--- FAIL: TestScript (0.08s)
    --- FAIL: TestScript/mod_pseudo_cache (5.23s)
        script_test.go:134: 2022-12-14T23:12:31Z
        script_test.go:136: $WORK=/workdir/tmp/cmd-go-test-1209887216/tmpdir4058640496/mod_pseudo_cache1935531625
        script_test.go:154: 
            > [!net] skip
            [condition not met]
            > [!git] skip
            [condition not met]
            > env GO111MODULE=on
...
            # pseudo-version of a commit, future resolution of that commit by hash should
            # choose the highest appropriate pseudo-version instead of the cached one. (5.223s)
            > go mod download -json golang.org/x/[email protected]
            [stdout]
            {
            	"Path": "golang.org/x/text",
            	"Version": "v0.0.0-20171215141712-a1b916ed6726",
            	"Error": "golang.org/x/[email protected]: invalid version: git fetch -f origin refs/heads/*:refs/heads/* refs/tags/*:refs/tags/* in /workdir/tmp/cmd-go-test-1209887216/tmpdir4058640496/mod_pseudo_cache1935531625/gopath/pkg/mod/cache/vcs/38515699458adac9c8b61a0b44f9ad7a5f6edd7bcc2d7fae95930ec78f71e1b4: exit status 128:\n\t23:12:32.916163 http.c:756              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t23:12:32.923585 http.c:756              == Info:   Trying 142.250.159.82:443...\n\t23:12:32.925638 http.c:756              == Info: Connected to go.googlesource.com (142.250.159.82) port 443 (#0)\n\t23:12:33.023598 http.c:756              == Info: found 387 certificates in /etc/ssl/certs\n\t23:12:33.023773 http.c:756              == Info: ALPN, offering h2\n\t23:12:33.023816 http.c:756              == Info: ALPN, offering http/1.1\n\t23:12:33.026460 http.c:756              == Info: SSL connection using TLS1.3 / ECDHE_RSA_AES_256_GCM_SHA384\n\t23:12:33.029164 http.c:756              == Info: \t server certificate verification OK\n\t23:12:33.029246 http.c:756              == Info: \t server certificate status verification SKIPPED\n\t23:12:33.029507 http.c:756              == Info: \t common name: *.googlecode.com (matched)\n\t23:12:33.029553 http.c:756              == Info: \t server certificate expiration date OK\n\t23:12:33.029580 http.c:756              == Info: \t server certificate activation date OK\n\t23:12:33.029638 http.c:756              == Info: \t certificate public key: EC/ECDSA\n\t23:12:33.029689 http.c:756              == Info: \t certificate version: #3\n\t23:12:33.029733 http.c:756              == Info: \t subject: CN=*.googlecode.com\n\t23:12:33.029778 http.c:756              == Info: \t start date: Mon, 07 Nov 2022 08:18:51 GMT\n\t23:12:33.029819 http.c:756              == Info: \t expire date: Mon, 30 Jan 2023 08:18:50 GMT\n\t23:12:33.029869 http.c:756              == Info: \t issuer: C=US,O=Google Trust Services LLC,CN=GTS CA 1C3\n\t23:12:33.029944 http.c:756              == Info: ALPN, server accepted to use h2\n\t23:12:33.030023 http.c:756              == Info: Using HTTP2, server supports multi-use\n\t23:12:33.030064 http.c:756              == Info: Connection state changed (HTTP/2 confirmed)\n\t23:12:33.030105 http.c:756              == Info: Copying HTTP/2 data in stream buffer to connection buffer after upgrade: len=0\n\t23:12:33.030275 http.c:756              == Info: Using Stream ID: 1 (easy handle 0x55cf88de69c0)\n\t23:12:33.030348 http.c:703              =\u003e Send header, 0000000197 bytes (0x000000c5)\n\t23:12:33.030380 http.c:715              =\u003e Send header: GET /text/info/refs?service=git-upload-pack HTTP/2\n\t23:12:33.030431 http.c:715              =\u003e Send header: Host: go.googlesource.com\n\t23:12:33.030455 http.c:715              =\u003e Send header: user-agent: git/2.30.2\n\t23:12:33.030477 http.c:715              =\u003e Send header: accept: */*\n\t23:12:33.030513 http.c:715              =\u003e Send header: accept-encoding: deflate, gzip, br\n\t23:12:33.030548 http.c:715              =\u003e Send header: pragma: no-cache\n\t23:12:33.030571 http.c:715              =\u003e Send header: git-protocol: version=2\n\t23:12:33.030593 http.c:715              =\u003e Send header:\n\t23:12:33.030658 http.c:756              == Info: Connection state changed (MAX_CONCURRENT_STREAMS == 100)!\n\t23:12:33.287760 http.c:703              \u003c= Recv header, 0000000013 bytes (0x0000000d)\n\t23:12:33.287808 http.c:715              \u003c= Recv header: HTTP/2 200\n\t23:12:33.287824 http.c:703              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t23:12:33.287829 http.c:715              \u003c= Recv header: cache-control: no-cache, max-age=0, must-revalidate\n\t23:12:33.287836 http.c:703              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t23:12:33.287839 http.c:715              \u003c= Recv header: content-length: 136\n\t23:12:33.287845 http.c:703              \u003c= Recv header, 0000000235 bytes (0x000000eb)\n\t23:12:33.287851 http.c:715              \u003c= Recv header: content-security-policy-report-only: script-src 'nonce-zBbIJXY6qyUOZl5Qnx_uMA' 'unsafe-inline' 'strict-dynamic' https: http: 'unsafe-eval';object-src 'none';base-uri 'self';report-uri https://csp.withgoogle.com/csp/gerritcodereview/1\n\t23:12:33.287858 http.c:703              \u003c= Recv header, 0000000059 bytes (0x0000003b)\n\t23:12:33.287861 http.c:715              \u003c= Recv header: content-type: application/x-git-upload-pack-advertisement\n\t23:12:33.287865 http.c:703              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t23:12:33.287871 http.c:715              \u003c= Recv header: expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t23:12:33.287875 http.c:703              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t23:12:33.287879 http.c:715              \u003c= Recv header: pragma: no-cache\n\t23:12:33.287883 http.c:703              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t23:12:33.287888 http.c:715              \u003c= Recv header: strict-transport-security: max-age=31536000; includeSubDomains; preload\n\t23:12:33.287894 http.c:703              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t23:12:33.287898 http.c:715              \u003c= Recv header: x-content-type-options: nosniff\n\t23:12:33.287902 http.c:703              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t23:12:33.287905 http.c:715              \u003c= Recv header: x-frame-options: SAMEORIGIN\n\t23:12:33.287909 http.c:703              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t23:12:33.287912 http.c:715              \u003c= Recv header: x-xss-protection: 0\n\t23:12:33.287916 http.c:703              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t23:12:33.287919 http.c:715              \u003c= Recv header: date: Wed, 14 Dec 2022 23:12:33 GMT\n\t23:12:33.287925 http.c:703              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t23:12:33.287928 http.c:715              \u003c= Recv header:\n\t23:12:33.288078 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact\n\t23:12:33.290883 http.c:756              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t23:12:33.290919 http.c:756              == Info: Found bundle for host go.googlesource.com: 0x55cf88ded600 [can multiplex]\n\t23:12:33.290935 http.c:756              == Info: Re-using existing connection! (#0) with host go.googlesource.com\n\t23:12:33.290944 http.c:756              == Info: Connected to go.googlesource.com (142.250.159.82) port 443 (#0)\n\t23:12:33.290978 http.c:756              == Info: Using Stream ID: 3 (easy handle 0x55cf88de69c0)\n\t23:12:33.291058 http.c:703              =\u003e Send header, 0000000269 bytes (0x0000010d)\n\t23:12:33.291075 http.c:715              =\u003e Send header: POST /text/git-upload-pack HTTP/2\n\t23:12:33.291079 http.c:715              =\u003e Send header: Host: go.googlesource.com\n\t23:12:33.291083 http.c:715              =\u003e Send header: user-agent: git/2.30.2\n\t23:12:33.291086 http.c:715              =\u003e Send header: accept-encoding: deflate, gzip, br\n\t23:12:33.291090 http.c:715              =\u003e Send header: content-type: application/x-git-upload-pack-request\n\t23:12:33.291094 http.c:715              =\u003e Send header: accept: application/x-git-upload-pack-result\n\t23:12:33.291097 http.c:715              =\u003e Send header: git-protocol: version=2\n\t23:12:33.291100 http.c:715              =\u003e Send header: content-length: 128\n\t23:12:33.291110 http.c:715              =\u003e Send header:\n\t23:12:33.291143 http.c:756              == Info: We are completely uploaded and fine\n\t23:12:33.320876 http.c:703              \u003c= Recv header, 0000000013 bytes (0x0000000d)\n\t23:12:33.320895 http.c:715              \u003c= Recv header: HTTP/2 200\n\t23:12:33.320901 http.c:703              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t23:12:33.320905 http.c:715              \u003c= Recv header: cache-control: no-cache, max-age=0, must-revalidate\n\t23:12:33.320909 http.c:703              \u003c= Recv header, 0000000235 bytes (0x000000eb)\n\t23:12:33.320914 http.c:715              \u003c= Recv header: content-security-policy-report-only: script-src 'nonce-WkBuos87fWjm9NynjTj-nQ' 'unsafe-inline' 'strict-dynamic' https: http: 'unsafe-eval';object-src 'none';base-uri 'self';report-uri https://csp.withgoogle.com/csp/gerritcodereview/1\n\t23:12:33.320921 http.c:703              \u003c= Recv header, 0000000052 bytes (0x00000034)\n\t23:12:33.320926 http.c:715              \u003c= Recv header: content-type: application/x-git-upload-pack-result\n\t23:12:33.320931 http.c:703              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t23:12:33.320934 http.c:715              \u003c= Recv header: expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t23:12:33.320938 http.c:703              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t23:12:33.320941 http.c:715              \u003c= Recv header: pragma: no-cache\n\t23:12:33.320944 http.c:703              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t23:12:33.320948 http.c:715              \u003c= Recv header: strict-transport-security: max-age=31536000; includeSubDomains; preload\n\t23:12:33.320953 http.c:703              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t23:12:33.320956 http.c:715              \u003c= Recv header: x-content-type-options: nosniff\n\t23:12:33.320960 http.c:703              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t23:12:33.320963 http.c:715              \u003c= Recv header: x-frame-options: SAMEORIGIN\n\t23:12:33.320967 http.c:703              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t23:12:33.320970 http.c:715              \u003c= Recv header: x-xss-protection: 0\n\t23:12:33.320973 http.c:703              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t23:12:33.320976 http.c:715              \u003c= Recv header: date: Wed, 14 Dec 2022 23:12:33 GMT\n\t23:12:33.320981 http.c:703              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t23:12:33.320985 http.c:715              \u003c= Recv header:\n\t23:12:33.325015 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact\n\t23:12:33.326439 http.c:756              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t23:12:33.326460 http.c:756              == Info: Found bundle for host go.googlesource.com: 0x55cf88ded600 [can multiplex]\n\t23:12:33.326508 http.c:756              == Info: 17 bytes stray data read before trying h2 connection\n\t23:12:33.326543 http.c:756              == Info: Re-using existing connection! (#0) with host go.googlesource.com\n\t23:12:33.326552 http.c:756              == Info: Connected to go.googlesource.com (142.250.159.82) port 443 (#0)\n\t23:12:33.326612 http.c:756              == Info: Using Stream ID: 5 (easy handle 0x55cf88de69c0)\n\t23:12:33.326653 http.c:703              =\u003e Send header, 0000000293 bytes (0x00000125)\n\t23:12:33.326665 http.c:715              =\u003e Send header: POST /text/git-upload-pack HTTP/2\n\t23:12:33.326682 http.c:715              =\u003e Send header: Host: go.googlesource.com\n\t23:12:33.326685 http.c:715              =\u003e Send header: user-agent: git/2.30.2\n\t23:12:33.326689 http.c:715              =\u003e Send header: accept-encoding: deflate, gzip, br\n\t23:12:33.326694 http.c:715              =\u003e Send header: content-type: application/x-git-upload-pack-request\n\t23:12:33.326697 http.c:715              =\u003e Send header: accept: application/x-git-upload-pack-result\n\t23:12:33.326700 http.c:715              =\u003e Send header: git-protocol: version=2\n\t23:12:33.326703 http.c:715              =\u003e Send header: content-encoding: gzip\n\t23:12:33.326706 http.c:715              =\u003e Send header: content-length: 238\n\t23:12:33.326709 http.c:715              =\u003e Send header:\n\t23:12:33.326730 http.c:756              == Info: We are completely uploaded and fine\n\t23:12:33.379873 http.c:703              \u003c= Recv header, 0000000013 bytes (0x0000000d)\n\t23:12:33.379903 http.c:715              \u003c= Recv header: HTTP/2 200\n\t23:12:33.379909 http.c:703              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t23:12:33.379914 http.c:715              \u003c= Recv header: cache-control: no-cache, max-age=0, must-revalidate\n\t23:12:33.379918 http.c:703              \u003c= Recv header, 0000000235 bytes (0x000000eb)\n\t23:12:33.379923 http.c:715              \u003c= Recv header: content-security-policy-report-only: script-src 'nonce-ZyikGnnYW8h7UMIoWwv2TQ' 'unsafe-inline' 'strict-dynamic' https: http: 'unsafe-eval';object-src 'none';base-uri 'self';report-uri https://csp.withgoogle.com/csp/gerritcodereview/1\n\t23:12:33.379929 http.c:703              \u003c= Recv header, 0000000052 bytes (0x00000034)\n\t23:12:33.379933 http.c:715              \u003c= Recv header: content-type: application/x-git-upload-pack-result\n\t23:12:33.379939 http.c:703              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t23:12:33.379943 http.c:715              \u003c= Recv header: expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t23:12:33.379947 http.c:703              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t23:12:33.379951 http.c:715              \u003c= Recv header: pragma: no-cache\n\t23:12:33.379954 http.c:703              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t23:12:33.379958 http.c:715              \u003c= Recv header: strict-transport-security: max-age=31536000; includeSubDomains; preload\n\t23:12:33.379962 http.c:703              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t23:12:33.379967 http.c:715              \u003c= Recv header: x-content-type-options: nosniff\n\t23:12:33.379972 http.c:703              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t23:12:33.379975 http.c:715              \u003c= Recv header: x-frame-options: SAMEORIGIN\n\t23:12:33.379979 http.c:703              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t23:12:33.379982 http.c:715              \u003c= Recv header: x-xss-protection: 0\n\t23:12:33.379986 http.c:703              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t23:12:33.379988 http.c:715              \u003c= Recv header: date: Wed, 14 Dec 2022 23:12:33 GMT\n\t23:12:33.379993 http.c:703              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t23:12:33.379996 http.c:715              \u003c= Recv header:\n\t23:12:37.149910 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact\n\terror: 13296 bytes of body are still expected\n\tfetch-pack: unexpected disconnect while reading sideband packet\n\tfatal: early EOF\n\tfatal: index-pack failed"
            }
        script_test.go:154: FAIL: mod_pseudo_cache.txt:12: go mod download -json golang.org/x/[email protected]: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2022-12-29 23:36 linux-386-longtest go@db36eca3 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:45809
https://vcs-test.golang.org rerouted to https://127.0.0.1:32785
go test proxy running at GOPROXY=http://127.0.0.1:38187/mod
2022/12/30 00:14:00 http: TLS handshake error from 127.0.0.1:58028: EOF
2022/12/30 00:14:00 http: TLS handshake error from 127.0.0.1:58042: EOF
2022/12/30 00:14:00 http: TLS handshake error from 127.0.0.1:58056: read tcp 127.0.0.1:32785->127.0.0.1:58056: read: connection reset by peer
2022/12/30 00:14:00 http: TLS handshake error from 127.0.0.1:58086: EOF
2022/12/30 00:14:00 http: TLS handshake error from 127.0.0.1:58070: EOF
2022/12/30 00:14:00 http: TLS handshake error from 127.0.0.1:58098: EOF
2022/12/30 00:14:00 http: TLS handshake error from 127.0.0.1:58110: EOF
...
--- FAIL: TestScript (0.09s)
    --- FAIL: TestScript/mod_pseudo_cache (3.89s)
        script_test.go:134: 2022-12-30T00:13:39Z
        script_test.go:136: $WORK=/workdir/tmp/cmd-go-test-4020010363/tmpdir3900272057/mod_pseudo_cache958655634
        script_test.go:154: 
            > [!net] skip
            [condition not met]
            > [!git] skip
            [condition not met]
            > env GO111MODULE=on
...
            # pseudo-version of a commit, future resolution of that commit by hash should
            # choose the highest appropriate pseudo-version instead of the cached one. (3.879s)
            > go mod download -json golang.org/x/[email protected]
            [stdout]
            {
            	"Path": "golang.org/x/text",
            	"Version": "v0.0.0-20171215141712-a1b916ed6726",
            	"Error": "golang.org/x/[email protected]: invalid version: git fetch -f origin refs/heads/*:refs/heads/* refs/tags/*:refs/tags/* in /workdir/tmp/cmd-go-test-4020010363/tmpdir3900272057/mod_pseudo_cache958655634/gopath/pkg/mod/cache/vcs/38515699458adac9c8b61a0b44f9ad7a5f6edd7bcc2d7fae95930ec78f71e1b4: exit status 128:\n\t00:13:39.950692 http.c:756              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t00:13:39.959013 http.c:756              == Info:   Trying 172.253.119.82:443...\n\t00:13:39.960401 http.c:756              == Info: Connected to go.googlesource.com (172.253.119.82) port 443 (#0)\n\t00:13:40.069381 http.c:756              == Info: found 387 certificates in /etc/ssl/certs\n\t00:13:40.069585 http.c:756              == Info: ALPN, offering h2\n\t00:13:40.069598 http.c:756              == Info: ALPN, offering http/1.1\n\t00:13:40.074580 http.c:756              == Info: SSL connection using TLS1.3 / ECDHE_RSA_AES_256_GCM_SHA384\n\t00:13:40.080201 http.c:756              == Info: \t server certificate verification OK\n\t00:13:40.080223 http.c:756              == Info: \t server certificate status verification SKIPPED\n\t00:13:40.080509 http.c:756              == Info: \t common name: *.googlecode.com (matched)\n\t00:13:40.080530 http.c:756              == Info: \t server certificate expiration date OK\n\t00:13:40.080541 http.c:756              == Info: \t server certificate activation date OK\n\t00:13:40.080563 http.c:756              == Info: \t certificate public key: EC/ECDSA\n\t00:13:40.080577 http.c:756              == Info: \t certificate version: #3\n\t00:13:40.080609 http.c:756              == Info: \t subject: CN=*.googlecode.com\n\t00:13:40.080631 http.c:756              == Info: \t start date: Mon, 28 Nov 2022 08:18:21 GMT\n\t00:13:40.080640 http.c:756              == Info: \t expire date: Mon, 20 Feb 2023 08:18:20 GMT\n\t00:13:40.080672 http.c:756              == Info: \t issuer: C=US,O=Google Trust Services LLC,CN=GTS CA 1C3\n\t00:13:40.080692 http.c:756              == Info: ALPN, server accepted to use h2\n\t00:13:40.080738 http.c:756              == Info: Using HTTP2, server supports multi-use\n\t00:13:40.080744 http.c:756              == Info: Connection state changed (HTTP/2 confirmed)\n\t00:13:40.080753 http.c:756              == Info: Copying HTTP/2 data in stream buffer to connection buffer after upgrade: len=0\n\t00:13:40.080835 http.c:756              == Info: Using Stream ID: 1 (easy handle 0x5612c83a59c0)\n\t00:13:40.080906 http.c:703              =\u003e Send header, 0000000197 bytes (0x000000c5)\n\t00:13:40.080916 http.c:715              =\u003e Send header: GET /text/info/refs?service=git-upload-pack HTTP/2\n\t00:13:40.080921 http.c:715              =\u003e Send header: Host: go.googlesource.com\n\t00:13:40.080926 http.c:715              =\u003e Send header: user-agent: git/2.30.2\n\t00:13:40.080930 http.c:715              =\u003e Send header: accept: */*\n\t00:13:40.080935 http.c:715              =\u003e Send header: accept-encoding: deflate, gzip, br\n\t00:13:40.080939 http.c:715              =\u003e Send header: pragma: no-cache\n\t00:13:40.080945 http.c:715              =\u003e Send header: git-protocol: version=2\n\t00:13:40.080949 http.c:715              =\u003e Send header:\n\t00:13:40.080981 http.c:756              == Info: Connection state changed (MAX_CONCURRENT_STREAMS == 100)!\n\t00:13:40.148393 http.c:703              \u003c= Recv header, 0000000013 bytes (0x0000000d)\n\t00:13:40.148416 http.c:715              \u003c= Recv header: HTTP/2 200\n\t00:13:40.148425 http.c:703              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t00:13:40.148431 http.c:715              \u003c= Recv header: cache-control: no-cache, max-age=0, must-revalidate\n\t00:13:40.148440 http.c:703              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t00:13:40.148445 http.c:715              \u003c= Recv header: content-length: 136\n\t00:13:40.148452 http.c:703              \u003c= Recv header, 0000000235 bytes (0x000000eb)\n\t00:13:40.148458 http.c:715              \u003c= Recv header: content-security-policy-report-only: script-src 'nonce-5sqE-8Ys8aKeC8zR0mdsWw' 'unsafe-inline' 'strict-dynamic' https: http: 'unsafe-eval';object-src 'none';base-uri 'self';report-uri https://csp.withgoogle.com/csp/gerritcodereview/1\n\t00:13:40.148477 http.c:703              \u003c= Recv header, 0000000059 bytes (0x0000003b)\n\t00:13:40.148481 http.c:715              \u003c= Recv header: content-type: application/x-git-upload-pack-advertisement\n\t00:13:40.148487 http.c:703              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t00:13:40.148492 http.c:715              \u003c= Recv header: expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t00:13:40.148497 http.c:703              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t00:13:40.148503 http.c:715              \u003c= Recv header: pragma: no-cache\n\t00:13:40.148508 http.c:703              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t00:13:40.148513 http.c:715              \u003c= Recv header: strict-transport-security: max-age=31536000; includeSubDomains; preload\n\t00:13:40.148519 http.c:703              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t00:13:40.148525 http.c:715              \u003c= Recv header: x-content-type-options: nosniff\n\t00:13:40.148530 http.c:703              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t00:13:40.148536 http.c:715              \u003c= Recv header: x-frame-options: SAMEORIGIN\n\t00:13:40.148540 http.c:703              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t00:13:40.148545 http.c:715              \u003c= Recv header: x-xss-protection: 0\n\t00:13:40.148549 http.c:703              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t00:13:40.148554 http.c:715              \u003c= Recv header: date: Fri, 30 Dec 2022 00:13:40 GMT\n\t00:13:40.148559 http.c:703              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t00:13:40.148563 http.c:715              \u003c= Recv header:\n\t00:13:40.148607 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact\n\t00:13:40.148912 http.c:756              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t00:13:40.148946 http.c:756              == Info: Found bundle for host go.googlesource.com: 0x5612c83ac600 [can multiplex]\n\t00:13:40.148967 http.c:756              == Info: Re-using existing connection! (#0) with host go.googlesource.com\n\t00:13:40.148979 http.c:756              == Info: Connected to go.googlesource.com (172.253.119.82) port 443 (#0)\n\t00:13:40.149023 http.c:756              == Info: Using Stream ID: 3 (easy handle 0x5612c83a59c0)\n\t00:13:40.149122 http.c:703              =\u003e Send header, 0000000269 bytes (0x0000010d)\n\t00:13:40.149147 http.c:715              =\u003e Send header: POST /text/git-upload-pack HTTP/2\n\t00:13:40.149155 http.c:715              =\u003e Send header: Host: go.googlesource.com\n\t00:13:40.149161 http.c:715              =\u003e Send header: user-agent: git/2.30.2\n\t00:13:40.149165 http.c:715              =\u003e Send header: accept-encoding: deflate, gzip, br\n\t00:13:40.149169 http.c:715              =\u003e Send header: content-type: application/x-git-upload-pack-request\n\t00:13:40.149174 http.c:715              =\u003e Send header: accept: application/x-git-upload-pack-result\n\t00:13:40.149178 http.c:715              =\u003e Send header: git-protocol: version=2\n\t00:13:40.149182 http.c:715              =\u003e Send header: content-length: 128\n\t00:13:40.149189 http.c:715              =\u003e Send header:\n\t00:13:40.149235 http.c:756              == Info: We are completely uploaded and fine\n\t00:13:40.171988 http.c:703              \u003c= Recv header, 0000000013 bytes (0x0000000d)\n\t00:13:40.172017 http.c:715              \u003c= Recv header: HTTP/2 200\n\t00:13:40.172026 http.c:703              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t00:13:40.172035 http.c:715              \u003c= Recv header: cache-control: no-cache, max-age=0, must-revalidate\n\t00:13:40.172045 http.c:703              \u003c= Recv header, 0000000235 bytes (0x000000eb)\n\t00:13:40.172052 http.c:715              \u003c= Recv header: content-security-policy-report-only: script-src 'nonce-Eiv1lAAn5Mly_SXlduPVgw' 'unsafe-inline' 'strict-dynamic' https: http: 'unsafe-eval';object-src 'none';base-uri 'self';report-uri https://csp.withgoogle.com/csp/gerritcodereview/1\n\t00:13:40.172060 http.c:703              \u003c= Recv header, 0000000052 bytes (0x00000034)\n\t00:13:40.172065 http.c:715              \u003c= Recv header: content-type: application/x-git-upload-pack-result\n\t00:13:40.172073 http.c:703              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t00:13:40.172079 http.c:715              \u003c= Recv header: expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t00:13:40.172087 http.c:703              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t00:13:40.172096 http.c:715              \u003c= Recv header: pragma: no-cache\n\t00:13:40.172103 http.c:703              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t00:13:40.172109 http.c:715              \u003c= Recv header: strict-transport-security: max-age=31536000; includeSubDomains; preload\n\t00:13:40.172116 http.c:703              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t00:13:40.172122 http.c:715              \u003c= Recv header: x-content-type-options: nosniff\n\t00:13:40.172126 http.c:703              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t00:13:40.172133 http.c:715              \u003c= Recv header: x-frame-options: SAMEORIGIN\n\t00:13:40.172140 http.c:703              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t00:13:40.172146 http.c:715              \u003c= Recv header: x-xss-protection: 0\n\t00:13:40.172153 http.c:703              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t00:13:40.172159 http.c:715              \u003c= Recv header: date: Fri, 30 Dec 2022 00:13:40 GMT\n\t00:13:40.172172 http.c:703              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t00:13:40.172178 http.c:715              \u003c= Recv header:\n\t00:13:40.174473 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact\n\t00:13:40.176352 http.c:756              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t00:13:40.176375 http.c:756              == Info: Found bundle for host go.googlesource.com: 0x5612c83ac600 [can multiplex]\n\t00:13:40.176414 http.c:756              == Info: 17 bytes stray data read before trying h2 connection\n\t00:13:40.176453 http.c:756              == Info: Re-using existing connection! (#0) with host go.googlesource.com\n\t00:13:40.176464 http.c:756              == Info: Connected to go.googlesource.com (172.253.119.82) port 443 (#0)\n\t00:13:40.176497 http.c:756              == Info: Using Stream ID: 5 (easy handle 0x5612c83a59c0)\n\t00:13:40.176542 http.c:703              =\u003e Send header, 0000000293 bytes (0x00000125)\n\t00:13:40.176554 http.c:715              =\u003e Send header: POST /text/git-upload-pack HTTP/2\n\t00:13:40.176559 http.c:715              =\u003e Send header: Host: go.googlesource.com\n\t00:13:40.176563 http.c:715              =\u003e Send header: user-agent: git/2.30.2\n\t00:13:40.176567 http.c:715              =\u003e Send header: accept-encoding: deflate, gzip, br\n\t00:13:40.176572 http.c:715              =\u003e Send header: content-type: application/x-git-upload-pack-request\n\t00:13:40.176576 http.c:715              =\u003e Send header: accept: application/x-git-upload-pack-result\n\t00:13:40.176587 http.c:715              =\u003e Send header: git-protocol: version=2\n\t00:13:40.176591 http.c:715              =\u003e Send header: content-encoding: gzip\n\t00:13:40.176595 http.c:715              =\u003e Send header: content-length: 238\n\t00:13:40.176599 http.c:715              =\u003e Send header:\n\t00:13:40.176625 http.c:756              == Info: We are completely uploaded and fine\n\t00:13:40.225161 http.c:703              \u003c= Recv header, 0000000013 bytes (0x0000000d)\n\t00:13:40.225184 http.c:715              \u003c= Recv header: HTTP/2 200\n\t00:13:40.225192 http.c:703              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t00:13:40.225198 http.c:715              \u003c= Recv header: cache-control: no-cache, max-age=0, must-revalidate\n\t00:13:40.225204 http.c:703              \u003c= Recv header, 0000000235 bytes (0x000000eb)\n\t00:13:40.225210 http.c:715              \u003c= Recv header: content-security-policy-report-only: script-src 'nonce-clFMcUaMTXHqkZjrnVyUBg' 'unsafe-inline' 'strict-dynamic' https: http: 'unsafe-eval';object-src 'none';base-uri 'self';report-uri https://csp.withgoogle.com/csp/gerritcodereview/1\n\t00:13:40.225217 http.c:703              \u003c= Recv header, 0000000052 bytes (0x00000034)\n\t00:13:40.225221 http.c:715              \u003c= Recv header: content-type: application/x-git-upload-pack-result\n\t00:13:40.225227 http.c:703              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t00:13:40.225232 http.c:715              \u003c= Recv header: expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t00:13:40.225237 http.c:703              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t00:13:40.225241 http.c:715              \u003c= Recv header: pragma: no-cache\n\t00:13:40.225246 http.c:703              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t00:13:40.225251 http.c:715              \u003c= Recv header: strict-transport-security: max-age=31536000; includeSubDomains; preload\n\t00:13:40.225273 http.c:703              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t00:13:40.225279 http.c:715              \u003c= Recv header: x-content-type-options: nosniff\n\t00:13:40.225294 http.c:703              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t00:13:40.225298 http.c:715              \u003c= Recv header: x-frame-options: SAMEORIGIN\n\t00:13:40.225303 http.c:703              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t00:13:40.225307 http.c:715              \u003c= Recv header: x-xss-protection: 0\n\t00:13:40.225312 http.c:703              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t00:13:40.225316 http.c:715              \u003c= Recv header: date: Fri, 30 Dec 2022 00:13:40 GMT\n\t00:13:40.225321 http.c:703              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t00:13:40.225325 http.c:715              \u003c= Recv header:\n\t00:13:43.274654 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact\n\terror: 63616 bytes of body are still expected\n\tfetch-pack: unexpected disconnect while reading sideband packet\n\tfatal: early EOF\n\tfatal: index-pack failed"
            }
        script_test.go:154: FAIL: mod_pseudo_cache.txt:12: go mod download -json golang.org/x/[email protected]: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2023-02-23 18:57 linux-amd64-longtest-race go@ebe49f98 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:39359
https://vcs-test.golang.org rerouted to https://127.0.0.1:35837
go test proxy running at GOPROXY=http://127.0.0.1:46877/mod
2023/02/23 19:52:24 http: TLS handshake error from 127.0.0.1:43520: EOF
2023/02/23 19:54:44 http: TLS handshake error from 127.0.0.1:55404: EOF
2023/02/23 19:54:44 http: TLS handshake error from 127.0.0.1:55468: EOF
2023/02/23 19:54:44 http: TLS handshake error from 127.0.0.1:55440: EOF
--- FAIL: TestScript (0.15s)
    --- FAIL: TestScript/get_dot_slash_download (289.97s)
        script_test.go:134: 2023-02-23T19:54:49Z
...
            19:55:40.087499 http.c:715              <= Recv header: x-frame-options: DENY
            19:55:40.087503 http.c:703              <= Recv header, 0000000002 bytes (0x00000002)
            19:55:40.087506 http.c:715              <= Recv header:
            19:59:39.765707 http.c:756              == Info: Connection #0 to host github.com left intact
            error: 238 bytes of body are still expected
            fetch-pack: unexpected disconnect while reading sideband packet
            fatal: early EOF
            fatal: index-pack failed
            package rsc.io/x86/x86asm: exit status 128
        script_test.go:154: FAIL: get_dot_slash_download.txt:10: go get ./pprof_mac_fix: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2023-03-28 17:52 linux-amd64-longtest-race go@422f4483 cmd/go/internal/modfetch.TestCodeRepo (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:35609
https://vcs-test.golang.org rerouted to https://127.0.0.1:43689
--- FAIL: TestCodeRepo (0.00s)
    --- FAIL: TestCodeRepo/golang.org_x_text/4e4a3210bb (35.46s)
        coderepo_test.go:621: repo.Stat("4e4a3210bb"): golang.org/x/text@4e4a3210bb: invalid version: git fetch -f origin refs/heads/*:refs/heads/* refs/tags/*:refs/tags/* in /workdir/tmp/gitrepo-test-358207175/modcache/cache/vcs/38515699458adac9c8b61a0b44f9ad7a5f6edd7bcc2d7fae95930ec78f71e1b4: exit status 128:
            	error: 48544 bytes of body are still expected
            	fetch-pack: unexpected disconnect while reading sideband packet
            	fatal: early EOF
            	fatal: index-pack failed

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2023-03-28 22:44 linux-amd64-longtest-race go@c5206936 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:33249
https://vcs-test.golang.org rerouted to https://127.0.0.1:34893
go test proxy running at GOPROXY=http://127.0.0.1:43421/mod
2023/03/28 23:38:49 http: TLS handshake error from 127.0.0.1:55340: EOF
2023/03/28 23:39:38 http: TLS handshake error from 127.0.0.1:54136: EOF
2023/03/28 23:39:38 http: TLS handshake error from 127.0.0.1:54130: EOF
2023/03/28 23:39:38 http: TLS handshake error from 127.0.0.1:54176: EOF
2023/03/28 23:39:38 http: TLS handshake error from 127.0.0.1:54160: read tcp 127.0.0.1:34893->127.0.0.1:54160: read: connection reset by peer
2023/03/28 23:40:03 http: TLS handshake error from 127.0.0.1:50060: read tcp 127.0.0.1:34893->127.0.0.1:50060: read: connection reset by peer
--- FAIL: TestScript (0.17s)
    --- FAIL: TestScript/get_non_pkg (1014.27s)
        script_test.go:134: 2023-03-28T23:42:58Z
        script_test.go:136: $WORK=/workdir/tmp/cmd-go-test-93755419/tmpdir26488224/get_non_pkg1348030532
        script_test.go:154: 
            > [!net] skip
            [condition not met]
            > [!git] skip
            [condition not met]
            > env GOBIN=$WORK/tmp/gobin
            > env GO111MODULE=off
...
            23:42:59.983370 http.c:715              <= Recv header:
            23:59:53.069539 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            error: 7232 bytes of body are still expected
            fetch-pack: unexpected disconnect while reading sideband packet
            fatal: early EOF
            fatal: index-pack failed
            package golang.org/x/tools: exit status 128
            [exit status 1]
            > stderr 'golang.org/x/tools: no Go files'
        script_test.go:154: FAIL: get_non_pkg.txt:8: stderr 'golang.org/x/tools: no Go files': no match for `(?m)golang.org/x/tools: no Go files` in stderr

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2023-04-03 20:02 linux-386-longtest go@7a5787f3 cmd/go.TestDefaultGOPATHGet (log) 
go test proxy running at GOPROXY=http://127.0.0.1:33251/mod
--- FAIL: TestDefaultGOPATHGet (2.67s)
    go_test.go:1388: running testgo [get -v github.com/golang/example/hello]
    go_test.go:1388: standard error:
    go_test.go:1388: github.com/golang/example (download)
        created GOPATH=/workdir/tmp/cmd-go-test-1108731757/gotest329189793/home/go; see 'go help gopath'
        get "golang.org/x/example/stringutil": found meta tag vcs.metaImport{Prefix:"golang.org/x/example", VCS:"git", RepoRoot:"https://go.googlesource.com/example"} at //golang.org/x/example/stringutil?go-get=1
        get "golang.org/x/example/stringutil": verifying non-authoritative meta tag
        golang.org/x/example (download)
        golang.org/x/example/stringutil
...
        20:28:40.661213 http.c:756              == Info: Failed sending HTTP2 data
        20:28:40.661219 http.c:756              == Info: Connection #0 to host github.com left intact
        error: RPC failed; curl 56 GnuTLS recv error (-9): Error decoding the received TLS packet.
        error: 1220 bytes of body are still expected
        fetch-pack: unexpected disconnect while reading sideband packet
        fatal: early EOF
        fatal: index-pack failed
        package github.com/golang/example/hello: exit status 128

    go_test.go:1394: go [get github.com/golang/example/hello] failed unexpectedly in /workdir/go/src/cmd/go: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2023-04-19 21:15 darwin-amd64-longtest go@42f89db1 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:50669
https://vcs-test.golang.org rerouted to https://127.0.0.1:50670
go test proxy running at GOPROXY=http://127.0.0.1:50671/mod
2023/04/19 18:00:52 http: TLS handshake error from 127.0.0.1:51883: read tcp 127.0.0.1:50670->127.0.0.1:51883: read: connection reset by peer
2023/04/19 18:00:52 http: TLS handshake error from 127.0.0.1:51889: EOF
2023/04/19 18:00:52 http: TLS handshake error from 127.0.0.1:51888: EOF
2023/04/19 18:00:54 http: TLS handshake error from 127.0.0.1:51901: read tcp 127.0.0.1:50670->127.0.0.1:51901: read: connection reset by peer
2023/04/19 18:00:54 http: TLS handshake error from 127.0.0.1:51902: read tcp 127.0.0.1:50670->127.0.0.1:51902: read: connection reset by peer
--- FAIL: TestScript (0.51s)
    --- FAIL: TestScript/get_dash_t (48.22s)
...
            18:06:11.916469 http.c:637              <= Recv header: alt-svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000
            18:06:11.916472 http.c:625              <= Recv header, 0000000002 bytes (0x00000002)
            18:06:11.916473 http.c:637              <= Recv header:
            18:06:41.051747 http.c:678              == Info: Connection #0 to host go.googlesource.com left intact
            error: 14576 bytes of body are still expected
            fetch-pack: unexpected disconnect while reading sideband packet
            fatal: early EOF
            fatal: fetch-pack: invalid index-pack output
            package golang.org/x/build/gerrit: exit status 128
        script_test.go:154: FAIL: get_dash_t.txt:7: go get -v -t github.com/rsc/go-get-issue-8181/a github.com/rsc/go-get-issue-8181/b: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2023-05-05 19:07 linux-amd64-longtest-race go@26899ef3 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:40637
https://vcs-test.golang.org rerouted to https://127.0.0.1:44053
go test proxy running at GOPROXY=http://127.0.0.1:40715/mod
2023/05/05 20:08:22 http: TLS handshake error from 127.0.0.1:58610: EOF
2023/05/05 20:08:22 http: TLS handshake error from 127.0.0.1:58592: EOF
2023/05/05 20:08:22 http: TLS handshake error from 127.0.0.1:58616: EOF
--- FAIL: TestScript (1.15s)
    --- FAIL: TestScript/get_non_pkg (24.38s)
        script_test.go:134: 2023-05-05T20:06:01Z
        script_test.go:136: $WORK=/workdir/tmp/cmd-go-test-2736401249/tmpdir2428894865/get_non_pkg152637076
...
            20:06:03.512035 http.c:715              <= Recv header:
            20:06:26.046951 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            error: 14768 bytes of body are still expected
            fetch-pack: unexpected disconnect while reading sideband packet
            fatal: early EOF
            fatal: index-pack failed
            package golang.org/x/tools: exit status 128
            [exit status 1]
            > stderr 'golang.org/x/tools: no Go files'
        script_test.go:154: FAIL: get_non_pkg.txt:8: stderr 'golang.org/x/tools: no Go files': no match for `(?m)golang.org/x/tools: no Go files` in stderr

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2023-05-10 16:32 linux-amd64-longtest go@95c4f320 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:40513
https://vcs-test.golang.org rerouted to https://127.0.0.1:42541
go test proxy running at GOPROXY=http://127.0.0.1:38731/mod
2023/05/10 16:58:59 http: TLS handshake error from 127.0.0.1:45754: read tcp 127.0.0.1:42541->127.0.0.1:45754: read: connection reset by peer
2023/05/10 16:58:59 http: TLS handshake error from 127.0.0.1:45744: read tcp 127.0.0.1:42541->127.0.0.1:45744: read: connection reset by peer
--- FAIL: TestScript (0.06s)
    --- FAIL: TestScript/get_non_pkg (239.32s)
        script_test.go:134: 2023-05-10T16:59:09Z
        script_test.go:136: $WORK=/workdir/tmp/cmd-go-test-2745485449/tmpdir146973992/get_non_pkg1614155128
        script_test.go:154: 
...
            16:59:10.914552 http.c:715              <= Recv header:
            17:03:09.019365 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            error: 9840 bytes of body are still expected
            fetch-pack: unexpected disconnect while reading sideband packet
            fatal: early EOF
            fatal: index-pack failed
            package golang.org/x/tools: exit status 128
            [exit status 1]
            > stderr 'golang.org/x/tools: no Go files'
        script_test.go:154: FAIL: get_non_pkg.txt:8: stderr 'golang.org/x/tools: no Go files': no match for `(?m)golang.org/x/tools: no Go files` in stderr
2023-05-10 16:34 linux-amd64-longtest go@945a2b17 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:41711
https://vcs-test.golang.org rerouted to https://127.0.0.1:44023
go test proxy running at GOPROXY=http://127.0.0.1:36815/mod
2023/05/10 17:01:57 http: TLS handshake error from 127.0.0.1:47628: read tcp 127.0.0.1:44023->127.0.0.1:47628: read: connection reset by peer
2023/05/10 17:01:57 http: TLS handshake error from 127.0.0.1:47684: EOF
2023/05/10 17:01:57 http: TLS handshake error from 127.0.0.1:47692: EOF
2023/05/10 17:01:57 http: TLS handshake error from 127.0.0.1:47722: EOF
2023/05/10 17:01:57 http: TLS handshake error from 127.0.0.1:47738: read tcp 127.0.0.1:44023->127.0.0.1:47738: read: connection reset by peer
2023/05/10 17:01:58 http: TLS handshake error from 127.0.0.1:47770: read tcp 127.0.0.1:44023->127.0.0.1:47770: read: connection reset by peer
--- FAIL: TestScript (0.06s)
    --- FAIL: TestScript/get_non_pkg (265.33s)
        script_test.go:134: 2023-05-10T16:58:43Z
        script_test.go:136: $WORK=/workdir/tmp/cmd-go-test-2471759881/tmpdir4214381023/get_non_pkg3971211746
        script_test.go:154: 
            > [!net:golang.org] skip
            [condition not met]
            > [!git] skip
            [condition not met]
            > env GOBIN=$WORK/tmp/gobin
            > env GO111MODULE=off
...
            16:58:44.921689 http.c:715              <= Recv header:
            17:03:09.223467 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            error: 9840 bytes of body are still expected
            fetch-pack: unexpected disconnect while reading sideband packet
            fatal: early EOF
            fatal: index-pack failed
            package golang.org/x/tools: exit status 128
            [exit status 1]
            > stderr 'golang.org/x/tools: no Go files'
        script_test.go:154: FAIL: get_non_pkg.txt:8: stderr 'golang.org/x/tools: no Go files': no match for `(?m)golang.org/x/tools: no Go files` in stderr

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2023-05-22 19:03 linux-386-longtest go@b66474e0 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:41865
https://vcs-test.golang.org rerouted to https://127.0.0.1:35881
go test proxy running at GOPROXY=http://127.0.0.1:45383/mod
2023/05/22 19:27:00 http: TLS handshake error from 127.0.0.1:54586: EOF
2023/05/22 19:27:49 http: TLS handshake error from 127.0.0.1:53996: EOF
2023/05/22 19:27:49 http: TLS handshake error from 127.0.0.1:53978: EOF
2023/05/22 19:27:49 http: TLS handshake error from 127.0.0.1:53990: EOF
2023/05/22 19:27:49 http: TLS handshake error from 127.0.0.1:54040: EOF
2023/05/22 19:27:54 http: TLS handshake error from 127.0.0.1:54106: EOF
2023/05/22 19:27:54 http: TLS handshake error from 127.0.0.1:54088: EOF
...
--- FAIL: TestScript (0.04s)
    --- FAIL: TestScript/get_dash_t (40.22s)
        script_test.go:134: 2023-05-22T19:26:23Z
        script_test.go:136: $WORK=/workdir/tmp/cmd-go-test-3897631737/tmpdir986243488/get_dash_t3825162604
        script_test.go:154: 
            # Tests issue 8181 (40.214s)
            > [!net:github.com] skip
            [condition not met]
            > [!git] skip
            [condition not met]
...
            19:26:26.178544 http.c:715              <= Recv header: date: Mon, 22 May 2023 19:26:26 GMT
            19:26:26.178546 http.c:703              <= Recv header, 0000000002 bytes (0x00000002)
            19:26:26.178548 http.c:715              <= Recv header:
            19:27:04.016657 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            error: 15696 bytes of body are still expected
            fetch-pack: unexpected disconnect while reading sideband packet
            fatal: early EOF
            fatal: index-pack failed
            package golang.org/x/build/gerrit: exit status 128
        script_test.go:154: FAIL: get_dash_t.txt:7: go get -v -t github.com/rsc/go-get-issue-8181/a github.com/rsc/go-get-issue-8181/b: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2023-05-22 19:05 linux-amd64-longtest go@6761bff4 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:42917
https://vcs-test.golang.org rerouted to https://127.0.0.1:40403
go test proxy running at GOPROXY=http://127.0.0.1:34519/mod
2023/05/22 19:37:52 http: TLS handshake error from 127.0.0.1:43708: EOF
2023/05/22 19:37:52 http: TLS handshake error from 127.0.0.1:43742: EOF
2023/05/22 19:37:53 http: TLS handshake error from 127.0.0.1:43836: read tcp 127.0.0.1:40403->127.0.0.1:43836: read: connection reset by peer
2023/05/22 19:37:53 http: TLS handshake error from 127.0.0.1:43810: read tcp 127.0.0.1:40403->127.0.0.1:43810: read: connection reset by peer
2023/05/22 19:37:53 http: TLS handshake error from 127.0.0.1:43822: EOF
--- FAIL: TestScript (0.05s)
    --- FAIL: TestScript/get_dash_t (81.69s)
...
            19:38:04.273391 http.c:715              <= Recv header: date: Mon, 22 May 2023 19:38:04 GMT
            19:38:04.273394 http.c:703              <= Recv header, 0000000002 bytes (0x00000002)
            19:38:04.273397 http.c:715              <= Recv header:
            19:39:24.073458 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            error: 14176 bytes of body are still expected
            fetch-pack: unexpected disconnect while reading sideband packet
            fatal: early EOF
            fatal: index-pack failed
            package golang.org/x/build/gerrit: exit status 128
        script_test.go:154: FAIL: get_dash_t.txt:7: go get -v -t github.com/rsc/go-get-issue-8181/a github.com/rsc/go-get-issue-8181/b: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-01-23 17:49 linux-386-longtest go@10e9ab55 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:44343
https://vcs-test.golang.org rerouted to https://127.0.0.1:46875
go test proxy running at GOPROXY=http://127.0.0.1:45681/mod
2024/01/23 18:26:40 http: TLS handshake error from 127.0.0.1:58360: EOF
2024/01/23 18:27:07 http: TLS handshake error from 127.0.0.1:52392: EOF
2024/01/23 18:27:07 http: TLS handshake error from 127.0.0.1:52414: read tcp 127.0.0.1:46875->127.0.0.1:52414: read: connection reset by peer
--- FAIL: TestScript (0.06s)
    --- FAIL: TestScript/mod_gonoproxy (4.83s)
        script_test.go:132: 2024-01-23T18:26:51Z
        script_test.go:134: $WORK=/workdir/tmp/cmd-go-test-3715226736/tmpdir1291239097/mod_gonoproxy4004153625
...
            	18:26:56.737668 http.c:756              == Info: Failed receiving HTTP2 data
            	��
            	18:26:56.737681 http.c:756              == Info: Failed sending HTTP2 data
            	18:26:56.737692 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            	error: RPC failed; curl 56 GnuTLS recv error (-54): Error in the pull function.
            	error: 15560 bytes of body are still expected
            	fetch-pack: unexpected disconnect while reading sideband packet
            	fatal: early EOF
            	fatal: index-pack failed
        script_test.go:156: FAIL: testdata/script/mod_gonoproxy.txt:50: go get golang.org/x/text: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-02-16 18:13 linux-amd64-longtest go@a0226c56 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:33985
https://vcs-test.golang.org rerouted to https://127.0.0.1:41223
go test proxy running at GOPROXY=http://127.0.0.1:44833/mod
2024/02/16 18:53:46 http: TLS handshake error from 127.0.0.1:59108: read tcp 127.0.0.1:41223->127.0.0.1:59108: read: connection reset by peer
--- FAIL: TestScript (0.06s)
    --- FAIL: TestScript/mod_gonoproxy (52.51s)
        script_test.go:132: 2024-02-16T18:52:48Z
        script_test.go:134: $WORK=/workdir/tmp/cmd-go-test-1446527427/tmpdir1572046907/mod_gonoproxy3569550938
        script_test.go:156: 
            > env GO111MODULE=on
...
            	18:53:36.898922 http.c:703              <= Recv header, 0000000037 bytes (0x00000025)
            	18:53:36.898925 http.c:715              <= Recv header: date: Fri, 16 Feb 2024 18:53:36 GMT
            	18:53:36.898930 http.c:703              <= Recv header, 0000000002 bytes (0x00000002)
            	18:53:36.898933 http.c:715              <= Recv header:
            	18:53:40.592452 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            	error: 26608 bytes of body are still expected
            	fetch-pack: unexpected disconnect while reading sideband packet
            	fatal: early EOF
            	fatal: index-pack failed
        script_test.go:156: FAIL: testdata/script/mod_gonoproxy.txt:51: go list -m all: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-03-08 01:59 gotip-linux-amd64-longtest go@b57a544f cmd/go.TestScript/mod_sumdb_golang (log) 
=== RUN   TestScript/mod_sumdb_golang
=== PAUSE TestScript/mod_sumdb_golang
=== CONT  TestScript/mod_sumdb_golang
    script_test.go:136: 2024-03-08T02:08:53Z
    script_test.go:138: $WORK=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-1360244815/tmpdir2387803132/mod_sumdb_golang1425496680
    script_test.go:160: 
        PATH=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-1360244815/tmpdir2387803132/testbin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/cache/tools/bin:/home/swarming/.swarming/w/ir/bbagent_utility_packages:/home/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages:/home/swarming/.swarming/w/ir/cipd_bin_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/home/swarming/.swarming/w/ir/cache/cipd_client:/home/swarming/.swarming/w/ir/cache/cipd_client/bin:/home/swarming/.swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	02:09:03.301706 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):
        	02:09:03.301743 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):
        	02:09:03.301779 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):
        	02:09:03.301798 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact
        	error: 12784 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:160: FAIL: testdata/script/mod_sumdb_golang.txt:20: go get rsc.io/[email protected]: exit status 1
--- FAIL: TestScript/mod_sumdb_golang (10.56s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-03-13 18:24 gotip-darwin-amd64-longtest go@4f07bb39 cmd/go.TestScript/mod_pseudo_cache (log) 
=== RUN   TestScript/mod_pseudo_cache
=== PAUSE TestScript/mod_pseudo_cache
=== CONT  TestScript/mod_pseudo_cache
    script_test.go:136: 2024-03-13T23:12:32Z
    script_test.go:138: $WORK=/Volumes/Work/s/w/ir/x/t/cmd-go-test-1875690528/tmpdir1456180730/mod_pseudo_cache1677857701
go proxy: no archive rsc.io v1.2.0: file does not exist
    script_test.go:160: 
        PATH=/Volumes/Work/s/w/ir/x/t/cmd-go-test-1875690528/tmpdir1456180730/testbin:/Volumes/Work/s/w/ir/x/w/goroot/bin:/Volumes/Work/s/w/ir/x/w/goroot/bin:/Volumes/Work/s/w/ir/x/w/goroot/bin:/Volumes/Work/s/w/ir/cache/tools/bin:/Volumes/Work/s/w/ir/bbagent_utility_packages:/Volumes/Work/s/w/ir/bbagent_utility_packages/bin:/Volumes/Work/s/w/ir/cipd_bin_packages:/Volumes/Work/s/w/ir/cipd_bin_packages/bin:/Volumes/Work/s/w/ir/cipd_bin_packages/cpython3:/Volumes/Work/s/w/ir/cipd_bin_packages/cpython3/bin:/Volumes/Work/s/w/ir/cache/cipd_client:/Volumes/Work/s/w/ir/cache/cipd_client/bin:/Volumes/Work/s/cipd_cache/bin:/opt/infra-tools:/opt/local/bin:/opt/local/sbin:/usr/local/sbin:/usr/local/git/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
        HOME=/no-home
        CCACHE_DISABLE=1
...
        # choose the highest appropriate pseudo-version instead of the cached one. (26.655s)
        > go mod download -json golang.org/x/[email protected]
        [stdout]
        {
        	"Path": "golang.org/x/text",
        	"Version": "v0.0.0-20171215141712-a1b916ed6726",
        	"Error": "golang.org/x/[email protected]: invalid version: git fetch -f origin refs/heads/*:refs/heads/* refs/tags/*:refs/tags/* in /Volumes/Work/s/w/ir/x/t/cmd-go-test-1875690528/tmpdir1456180730/mod_pseudo_cache1677857701/gopath/pkg/mod/cache/vcs/38515699458adac9c8b61a0b44f9ad7a5f6edd7bcc2d7fae95930ec78f71e1b4: exit status 128:\n\t16:12:33.603842 http.c:699              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t16:12:33.610178 http.c:699              == Info:   Trying 172.253.63.82...\n\t16:12:33.610199 http.c:699              == Info: TCP_NODELAY set\n\t16:12:33.612591 http.c:699              == Info: Connected to go.googlesource.com (172.253.63.82) port 443 (#0)\n\t16:12:33.854482 http.c:699              == Info: TLS 1.2 connection using TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256\n\t16:12:33.854798 http.c:699              == Info: Server certificate: *.googlecode.com\n\t16:12:33.854926 http.c:699              == Info: Server certificate: GTS CA 1C3\n\t16:12:33.855028 http.c:699              == Info: Server certificate: GTS Root R1\n\t16:12:33.855144 http.c:646              =\u003e Send header, 0000000207 bytes (0x000000cf)\n\t16:12:33.855165 http.c:658              =\u003e Send header: GET /text/info/refs?service=git-upload-pack HTTP/1.1\n\t16:12:33.855172 http.c:658              =\u003e Send header: Host: go.googlesource.com\n\t16:12:33.855176 http.c:658              =\u003e Send header: User-Agent: git/2.39.2.chromium.11\n\t16:12:33.855183 http.c:658              =\u003e Send header: Accept: */*\n\t16:12:33.855190 http.c:658              =\u003e Send header: Accept-Encoding: deflate, gzip\n\t16:12:33.855195 http.c:658              =\u003e Send header: Pragma: no-cache\n\t16:12:33.855199 http.c:658              =\u003e Send header: Git-Protocol: version=2\n\t16:12:33.855204 http.c:658              =\u003e Send header:\n\t16:12:33.948933 http.c:646              \u003c= Recv header, 0000000017 bytes (0x00000011)\n\t16:12:33.948949 http.c:658              \u003c= Recv header: HTTP/1.1 200 OK\n\t16:12:33.948954 http.c:646              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t16:12:33.948958 http.c:658              \u003c= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate\n\t16:12:33.948962 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t16:12:33.948965 http.c:658              \u003c= Recv header: Content-Length: 151\n\t16:12:33.948970 http.c:646              \u003c= Recv header, 0000000059 bytes (0x0000003b)\n\t16:12:33.948973 http.c:658              \u003c= Recv header: Content-Type: application/x-git-upload-pack-advertisement\n\t16:12:33.948976 http.c:646              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t16:12:33.948980 http.c:658              \u003c= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t16:12:33.948983 http.c:646              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t16:12:33.948988 http.c:658              \u003c= Recv header: Pragma: no-cache\n\t16:12:33.948992 http.c:646              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t16:12:33.948996 http.c:658              \u003c= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains; preload\n\t16:12:33.948999 http.c:646              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t16:12:33.949004 http.c:658              \u003c= Recv header: X-Content-Type-Options: nosniff\n\t16:12:33.949007 http.c:646              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t16:12:33.949011 http.c:658              \u003c= Recv header: X-Frame-Options: SAMEORIGIN\n\t16:12:33.949014 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t16:12:33.949018 http.c:658              \u003c= Recv header: X-Xss-Protection: 0\n\t16:12:33.949022 http.c:646              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t16:12:33.949025 http.c:658              \u003c= Recv header: Date: Wed, 13 Mar 2024 23:12:33 GMT\n\t16:12:33.949029 http.c:646              \u003c= Recv header, 0000000057 bytes (0x00000039)\n\t16:12:33.949032 http.c:658              \u003c= Recv header: Alt-Svc: h3=\":443\"; ma=2592000,h3-29=\":443\"; ma=2592000\n\t16:12:33.949037 http.c:646              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t16:12:33.949040 http.c:658              \u003c= Recv header:\n\t16:12:33.949052 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact\n\t16:12:33.949260 http.c:699              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t16:12:33.949273 http.c:699              == Info: Found bundle for host go.googlesource.com: 0x600002c70000 [can pipeline]\n\t16:12:33.949286 http.c:699              == Info: Re-using existing connection! (#0) with host go.googlesource.com\n\t16:12:33.949293 http.c:699              == Info: Connected to go.googlesource.com (172.253.63.82) port 443 (#0)\n\t16:12:33.949340 http.c:646              =\u003e Send header, 0000000279 bytes (0x00000117)\n\t16:12:33.949349 http.c:658              =\u003e Send header: POST /text/git-upload-pack HTTP/1.1\n\t16:12:33.949352 http.c:658              =\u003e Send header: Host: go.googlesource.com\n\t16:12:33.949355 http.c:658              =\u003e Send header: User-Agent: git/2.39.2.chromium.11\n\t16:12:33.949358 http.c:658              =\u003e Send header: Accept-Encoding: deflate, gzip\n\t16:12:33.949362 http.c:658              =\u003e Send header: Content-Type: application/x-git-upload-pack-request\n\t16:12:33.949365 http.c:658              =\u003e Send header: Accept: application/x-git-upload-pack-result\n\t16:12:33.949368 http.c:658              =\u003e Send header: Git-Protocol: version=2\n\t16:12:33.949384 http.c:658              =\u003e Send header: Content-Length: 128\n\t16:12:33.949391 http.c:658              =\u003e Send header:\n\t16:12:33.949398 http.c:699              == Info: upload completely sent off: 128 out of 128 bytes\n\t16:12:34.316204 http.c:646              \u003c= Recv header, 0000000017 bytes (0x00000011)\n\t16:12:34.316226 http.c:658              \u003c= Recv header: HTTP/1.1 200 OK\n\t16:12:34.316235 http.c:646              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t16:12:34.316242 http.c:658              \u003c= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate\n\t16:12:34.316251 http.c:646              \u003c= Recv header, 0000000052 bytes (0x00000034)\n\t16:12:34.316256 http.c:658              \u003c= Recv header: Content-Type: application/x-git-upload-pack-result\n\t16:12:34.316263 http.c:646              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t16:12:34.316271 http.c:658              \u003c= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t16:12:34.316278 http.c:646              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t16:12:34.316286 http.c:658              \u003c= Recv header: Pragma: no-cache\n\t16:12:34.316292 http.c:646              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t16:12:34.316300 http.c:658              \u003c= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains; preload\n\t16:12:34.316309 http.c:646              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t16:12:34.316315 http.c:658              \u003c= Recv header: X-Content-Type-Options: nosniff\n\t16:12:34.316322 http.c:646              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t16:12:34.316328 http.c:658              \u003c= Recv header: X-Frame-Options: SAMEORIGIN\n\t16:12:34.316376 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t16:12:34.316389 http.c:658              \u003c= Recv header: X-Xss-Protection: 0\n\t16:12:34.316396 http.c:646              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t16:12:34.316469 http.c:658              \u003c= Recv header: Date: Wed, 13 Mar 2024 23:12:34 GMT\n\t16:12:34.316482 http.c:646              \u003c= Recv header, 0000000028 bytes (0x0000001c)\n\t16:12:34.316511 http.c:658              \u003c= Recv header: Transfer-Encoding: chunked\n\t16:12:34.316518 http.c:646              \u003c= Recv header, 0000000057 bytes (0x00000039)\n\t16:12:34.316525 http.c:658              \u003c= Recv header: Alt-Svc: h3=\":443\"; ma=2592000,h3-29=\":443\"; ma=2592000\n\t16:12:34.316532 http.c:646              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t16:12:34.316541 http.c:658              \u003c= Recv header:\n\t16:12:34.331065 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact\n\t16:12:34.336392 http.c:699              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t16:12:34.336421 http.c:699              == Info: Found bundle for host go.googlesource.com: 0x600002c70000 [can pipeline]\n\t16:12:34.336450 http.c:699              == Info: Re-using existing connection! (#0) with host go.googlesource.com\n\t16:12:34.336464 http.c:699              == Info: Connected to go.googlesource.com (172.253.63.82) port 443 (#0)\n\t16:12:34.336553 http.c:646              =\u003e Send header, 0000000303 bytes (0x0000012f)\n\t16:12:34.336568 http.c:658              =\u003e Send header: POST /text/git-upload-pack HTTP/1.1\n\t16:12:34.336574 http.c:658              =\u003e Send header: Host: go.googlesource.com\n\t16:12:34.336594 http.c:658              =\u003e Send header: User-Agent: git/2.39.2.chromium.11\n\t16:12:34.336597 http.c:658              =\u003e Send header: Accept-Encoding: deflate, gzip\n\t16:12:34.336601 http.c:658              =\u003e Send header: Content-Type: application/x-git-upload-pack-request\n\t16:12:34.336623 http.c:658              =\u003e Send header: Accept: application/x-git-upload-pack-result\n\t16:12:34.336628 http.c:658              =\u003e Send header: Git-Protocol: version=2\n\t16:12:34.336633 http.c:658              =\u003e Send header: Content-Encoding: gzip\n\t16:12:34.336639 http.c:658              =\u003e Send header: Content-Length: 264\n\t16:12:34.336644 http.c:658              =\u003e Send header:\n\t16:12:34.336654 http.c:699              == Info: upload completely sent off: 264 out of 264 bytes\n\t16:12:34.651188 http.c:646              \u003c= Recv header, 0000000017 bytes (0x00000011)\n\t16:12:34.651220 http.c:658              \u003c= Recv header: HTTP/1.1 200 OK\n\t16:12:34.651231 http.c:646              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t16:12:34.651237 http.c:658              \u003c= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate\n\t16:12:34.651244 http.c:646              \u003c= Recv header, 0000000052 bytes (0x00000034)\n\t16:12:34.651250 http.c:658              \u003c= Recv header: Content-Type: application/x-git-upload-pack-result\n\t16:12:34.651256 http.c:646              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t16:12:34.651264 http.c:658              \u003c= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t16:12:34.651271 http.c:646              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t16:12:34.651277 http.c:658              \u003c= Recv header: Pragma: no-cache\n\t16:12:34.651283 http.c:646              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t16:12:34.651292 http.c:658              \u003c= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains; preload\n\t16:12:34.651298 http.c:646              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t16:12:34.651303 http.c:658              \u003c= Recv header: X-Content-Type-Options: nosniff\n\t16:12:34.651309 http.c:646              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t16:12:34.651314 http.c:658              \u003c= Recv header: X-Frame-Options: SAMEORIGIN\n\t16:12:34.651320 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t16:12:34.651326 http.c:658              \u003c= Recv header: X-Xss-Protection: 0\n\t16:12:34.651360 http.c:646              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t16:12:34.651373 http.c:658              \u003c= Recv header: Date: Wed, 13 Mar 2024 23:12:34 GMT\n\t16:12:34.651382 http.c:646              \u003c= Recv header, 0000000028 bytes (0x0000001c)\n\t16:12:34.651388 http.c:658              \u003c= Recv header: Transfer-Encoding: chunked\n\t16:12:34.651396 http.c:646              \u003c= Recv header, 0000000057 bytes (0x00000039)\n\t16:12:34.651402 http.c:658              \u003c= Recv header: Alt-Svc: h3=\":443\"; ma=2592000,h3-29=\":443\"; ma=2592000\n\t16:12:34.651410 http.c:646              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t16:12:34.651415 http.c:658              \u003c= Recv header:\n\t16:12:59.109195 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact\n\terror: 9712 bytes of body are still expected\n\tfetch-pack: unexpected disconnect while reading sideband packet\n\tfatal: early EOF\n\tfatal: fetch-pack: invalid index-pack output"
        }
    script_test.go:160: FAIL: testdata/script/mod_pseudo_cache.txt:12: go mod download -json golang.org/x/[email protected]: exit status 1
--- FAIL: TestScript/mod_pseudo_cache (26.68s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-03-15 17:12 gotip-darwin-amd64-longtest go@6f121623 cmd/go.TestScript/mod_pseudo_cache (log) 
=== RUN   TestScript/mod_pseudo_cache
=== PAUSE TestScript/mod_pseudo_cache
=== CONT  TestScript/mod_pseudo_cache
    script_test.go:136: 2024-03-15T22:57:26Z
    script_test.go:138: $WORK=/Volumes/Work/s/w/ir/x/t/cmd-go-test-1598555105/tmpdir337184833/mod_pseudo_cache1298070589
    script_test.go:160: 
        PATH=/Volumes/Work/s/w/ir/x/t/cmd-go-test-1598555105/tmpdir337184833/testbin:/Volumes/Work/s/w/ir/x/w/goroot/bin:/Volumes/Work/s/w/ir/x/w/goroot/bin:/Volumes/Work/s/w/ir/x/w/goroot/bin:/Volumes/Work/s/w/ir/cache/tools/bin:/Volumes/Work/s/w/ir/bbagent_utility_packages:/Volumes/Work/s/w/ir/bbagent_utility_packages/bin:/Volumes/Work/s/w/ir/cipd_bin_packages:/Volumes/Work/s/w/ir/cipd_bin_packages/bin:/Volumes/Work/s/w/ir/cipd_bin_packages/cpython3:/Volumes/Work/s/w/ir/cipd_bin_packages/cpython3/bin:/Volumes/Work/s/w/ir/cache/cipd_client:/Volumes/Work/s/w/ir/cache/cipd_client/bin:/Volumes/Work/s/cipd_cache/bin:/opt/infra-tools:/opt/local/bin:/opt/local/sbin:/usr/local/sbin:/usr/local/git/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        # choose the highest appropriate pseudo-version instead of the cached one. (28.646s)
        > go mod download -json golang.org/x/[email protected]
        [stdout]
        {
        	"Path": "golang.org/x/text",
        	"Version": "v0.0.0-20171215141712-a1b916ed6726",
        	"Error": "golang.org/x/[email protected]: invalid version: git fetch -f origin refs/heads/*:refs/heads/* refs/tags/*:refs/tags/* in /Volumes/Work/s/w/ir/x/t/cmd-go-test-1598555105/tmpdir337184833/mod_pseudo_cache1298070589/gopath/pkg/mod/cache/vcs/38515699458adac9c8b61a0b44f9ad7a5f6edd7bcc2d7fae95930ec78f71e1b4: exit status 128:\n\t15:57:27.431017 http.c:699              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t15:57:27.439282 http.c:699              == Info:   Trying 172.253.63.82...\n\t15:57:27.439322 http.c:699              == Info: TCP_NODELAY set\n\t15:57:27.441711 http.c:699              == Info: Connected to go.googlesource.com (172.253.63.82) port 443 (#0)\n\t15:57:27.688076 http.c:699              == Info: TLS 1.2 connection using TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256\n\t15:57:27.688420 http.c:699              == Info: Server certificate: *.googlecode.com\n\t15:57:27.688722 http.c:699              == Info: Server certificate: GTS CA 1C3\n\t15:57:27.688906 http.c:699              == Info: Server certificate: GTS Root R1\n\t15:57:27.689072 http.c:646              =\u003e Send header, 0000000207 bytes (0x000000cf)\n\t15:57:27.689102 http.c:658              =\u003e Send header: GET /text/info/refs?service=git-upload-pack HTTP/1.1\n\t15:57:27.689112 http.c:658              =\u003e Send header: Host: go.googlesource.com\n\t15:57:27.689117 http.c:658              =\u003e Send header: User-Agent: git/2.39.2.chromium.11\n\t15:57:27.689123 http.c:658              =\u003e Send header: Accept: */*\n\t15:57:27.689129 http.c:658              =\u003e Send header: Accept-Encoding: deflate, gzip\n\t15:57:27.689173 http.c:658              =\u003e Send header: Pragma: no-cache\n\t15:57:27.689225 http.c:658              =\u003e Send header: Git-Protocol: version=2\n\t15:57:27.689272 http.c:658              =\u003e Send header:\n\t15:57:27.827287 http.c:646              \u003c= Recv header, 0000000017 bytes (0x00000011)\n\t15:57:27.827363 http.c:658              \u003c= Recv header: HTTP/1.1 200 OK\n\t15:57:27.827474 http.c:646              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t15:57:27.829644 http.c:658              \u003c= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate\n\t15:57:27.829671 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t15:57:27.829679 http.c:658              \u003c= Recv header: Content-Length: 151\n\t15:57:27.829686 http.c:646              \u003c= Recv header, 0000000059 bytes (0x0000003b)\n\t15:57:27.829692 http.c:658              \u003c= Recv header: Content-Type: application/x-git-upload-pack-advertisement\n\t15:57:27.829699 http.c:646              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t15:57:27.829706 http.c:658              \u003c= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t15:57:27.829712 http.c:646              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t15:57:27.829718 http.c:658              \u003c= Recv header: Pragma: no-cache\n\t15:57:27.829725 http.c:646              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t15:57:27.829733 http.c:658              \u003c= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains; preload\n\t15:57:27.829739 http.c:646              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t15:57:27.829744 http.c:658              \u003c= Recv header: X-Content-Type-Options: nosniff\n\t15:57:27.829750 http.c:646              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t15:57:27.829755 http.c:658              \u003c= Recv header: X-Frame-Options: SAMEORIGIN\n\t15:57:27.831409 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t15:57:27.831486 http.c:658              \u003c= Recv header: X-Xss-Protection: 0\n\t15:57:27.831891 http.c:646              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t15:57:27.831902 http.c:658              \u003c= Recv header: Date: Fri, 15 Mar 2024 22:57:27 GMT\n\t15:57:27.831908 http.c:646              \u003c= Recv header, 0000000057 bytes (0x00000039)\n\t15:57:27.831913 http.c:658              \u003c= Recv header: Alt-Svc: h3=\":443\"; ma=2592000,h3-29=\":443\"; ma=2592000\n\t15:57:27.831918 http.c:646              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t15:57:27.831921 http.c:658              \u003c= Recv header:\n\t15:57:27.831935 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact\n\t15:57:27.832291 http.c:699              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t15:57:27.832315 http.c:699              == Info: Found bundle for host go.googlesource.com: 0x60000285c120 [can pipeline]\n\t15:57:27.832373 http.c:699              == Info: Re-using existing connection! (#0) with host go.googlesource.com\n\t15:57:27.832395 http.c:699              == Info: Connected to go.googlesource.com (172.253.63.82) port 443 (#0)\n\t15:57:27.832530 http.c:646              =\u003e Send header, 0000000279 bytes (0x00000117)\n\t15:57:27.832597 http.c:658              =\u003e Send header: POST /text/git-upload-pack HTTP/1.1\n\t15:57:27.832609 http.c:658              =\u003e Send header: Host: go.googlesource.com\n\t15:57:27.832615 http.c:658              =\u003e Send header: User-Agent: git/2.39.2.chromium.11\n\t15:57:27.832620 http.c:658              =\u003e Send header: Accept-Encoding: deflate, gzip\n\t15:57:27.832626 http.c:658              =\u003e Send header: Content-Type: application/x-git-upload-pack-request\n\t15:57:27.832631 http.c:658              =\u003e Send header: Accept: application/x-git-upload-pack-result\n\t15:57:27.832636 http.c:658              =\u003e Send header: Git-Protocol: version=2\n\t15:57:27.832644 http.c:658              =\u003e Send header: Content-Length: 128\n\t15:57:27.832649 http.c:658              =\u003e Send header:\n\t15:57:27.832660 http.c:699              == Info: upload completely sent off: 128 out of 128 bytes\n\t15:57:27.863173 http.c:646              \u003c= Recv header, 0000000017 bytes (0x00000011)\n\t15:57:27.863260 http.c:658              \u003c= Recv header: HTTP/1.1 200 OK\n\t15:57:27.863319 http.c:646              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t15:57:27.863400 http.c:658              \u003c= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate\n\t15:57:27.863459 http.c:646              \u003c= Recv header, 0000000052 bytes (0x00000034)\n\t15:57:27.863628 http.c:658              \u003c= Recv header: Content-Type: application/x-git-upload-pack-result\n\t15:57:27.863719 http.c:646              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t15:57:27.863790 http.c:658              \u003c= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t15:57:27.863886 http.c:646              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t15:57:27.863958 http.c:658              \u003c= Recv header: Pragma: no-cache\n\t15:57:27.864035 http.c:646              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t15:57:27.864106 http.c:658              \u003c= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains; preload\n\t15:57:27.864178 http.c:646              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t15:57:27.864239 http.c:658              \u003c= Recv header: X-Content-Type-Options: nosniff\n\t15:57:27.864274 http.c:646              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t15:57:27.864401 http.c:658              \u003c= Recv header: X-Frame-Options: SAMEORIGIN\n\t15:57:27.864472 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t15:57:27.864504 http.c:658              \u003c= Recv header: X-Xss-Protection: 0\n\t15:57:27.864596 http.c:646              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t15:57:27.864682 http.c:658              \u003c= Recv header: Date: Fri, 15 Mar 2024 22:57:27 GMT\n\t15:57:27.864763 http.c:646              \u003c= Recv header, 0000000028 bytes (0x0000001c)\n\t15:57:27.864802 http.c:658              \u003c= Recv header: Transfer-Encoding: chunked\n\t15:57:27.864905 http.c:646              \u003c= Recv header, 0000000057 bytes (0x00000039)\n\t15:57:27.864943 http.c:658              \u003c= Recv header: Alt-Svc: h3=\":443\"; ma=2592000,h3-29=\":443\"; ma=2592000\n\t15:57:27.865090 http.c:646              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t15:57:27.865127 http.c:658              \u003c= Recv header:\n\t15:57:27.867131 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact\n\t15:57:27.872524 http.c:699              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t15:57:27.872553 http.c:699              == Info: Found bundle for host go.googlesource.com: 0x60000285c120 [can pipeline]\n\t15:57:27.872625 http.c:699              == Info: Re-using existing connection! (#0) with host go.googlesource.com\n\t15:57:27.872694 http.c:699              == Info: Connected to go.googlesource.com (172.253.63.82) port 443 (#0)\n\t15:57:27.872875 http.c:646              =\u003e Send header, 0000000303 bytes (0x0000012f)\n\t15:57:27.872910 http.c:658              =\u003e Send header: POST /text/git-upload-pack HTTP/1.1\n\t15:57:27.872938 http.c:658              =\u003e Send header: Host: go.googlesource.com\n\t15:57:27.872944 http.c:658              =\u003e Send header: User-Agent: git/2.39.2.chromium.11\n\t15:57:27.872948 http.c:658              =\u003e Send header: Accept-Encoding: deflate, gzip\n\t15:57:27.872953 http.c:658              =\u003e Send header: Content-Type: application/x-git-upload-pack-request\n\t15:57:27.872958 http.c:658              =\u003e Send header: Accept: application/x-git-upload-pack-result\n\t15:57:27.872965 http.c:658              =\u003e Send header: Git-Protocol: version=2\n\t15:57:27.872971 http.c:658              =\u003e Send header: Content-Encoding: gzip\n\t15:57:27.872976 http.c:658              =\u003e Send header: Content-Length: 264\n\t15:57:27.872980 http.c:658              =\u003e Send header:\n\t15:57:27.872994 http.c:699              == Info: upload completely sent off: 264 out of 264 bytes\n\t15:57:28.445616 http.c:646              \u003c= Recv header, 0000000017 bytes (0x00000011)\n\t15:57:28.445631 http.c:658              \u003c= Recv header: HTTP/1.1 200 OK\n\t15:57:28.445636 http.c:646              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t15:57:28.445640 http.c:658              \u003c= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate\n\t15:57:28.445644 http.c:646              \u003c= Recv header, 0000000052 bytes (0x00000034)\n\t15:57:28.445646 http.c:658              \u003c= Recv header: Content-Type: application/x-git-upload-pack-result\n\t15:57:28.445678 http.c:646              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t15:57:28.445685 http.c:658              \u003c= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t15:57:28.445692 http.c:646              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t15:57:28.445698 http.c:658              \u003c= Recv header: Pragma: no-cache\n\t15:57:28.445704 http.c:646              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t15:57:28.445711 http.c:658              \u003c= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains; preload\n\t15:57:28.445718 http.c:646              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t15:57:28.445724 http.c:658              \u003c= Recv header: X-Content-Type-Options: nosniff\n\t15:57:28.445732 http.c:646              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t15:57:28.445738 http.c:658              \u003c= Recv header: X-Frame-Options: SAMEORIGIN\n\t15:57:28.445745 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t15:57:28.445752 http.c:658              \u003c= Recv header: X-Xss-Protection: 0\n\t15:57:28.445759 http.c:646              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t15:57:28.445764 http.c:658              \u003c= Recv header: Date: Fri, 15 Mar 2024 22:57:28 GMT\n\t15:57:28.445771 http.c:646              \u003c= Recv header, 0000000028 bytes (0x0000001c)\n\t15:57:28.445777 http.c:658              \u003c= Recv header: Transfer-Encoding: chunked\n\t15:57:28.445784 http.c:646              \u003c= Recv header, 0000000057 bytes (0x00000039)\n\t15:57:28.445790 http.c:658              \u003c= Recv header: Alt-Svc: h3=\":443\"; ma=2592000,h3-29=\":443\"; ma=2592000\n\t15:57:28.445798 http.c:646              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t15:57:28.445806 http.c:658              \u003c= Recv header:\n\t15:57:55.025185 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact\n\terror: 11760 bytes of body are still expected\n\tfetch-pack: unexpected disconnect while reading sideband packet\n\tfatal: early EOF\n\tfatal: fetch-pack: invalid index-pack output"
        }
    script_test.go:160: FAIL: testdata/script/mod_pseudo_cache.txt:12: go mod download -json golang.org/x/[email protected]: exit status 1
--- FAIL: TestScript/mod_pseudo_cache (28.66s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-03-19 11:34 darwin-amd64-longtest go@207511a0 cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:50274
https://vcs-test.golang.org rerouted to https://127.0.0.1:50275
go test proxy running at GOPROXY=http://127.0.0.1:50276/mod
2024/03/19 09:14:39 http: TLS handshake error from 127.0.0.1:50955: read tcp 127.0.0.1:50275->127.0.0.1:50955: read: connection reset by peer
--- FAIL: TestScript (0.84s)
    --- FAIL: TestScript/mod_get_direct (105.93s)
        script_test.go:136: 2024-03-19T13:15:04Z
        script_test.go:138: $WORK=/tmp/buildlet/tmp/cmd-go-test-645823445/tmpdir1039459990/mod_get_direct2282966876
        script_test.go:160: 
            # Regression test for golang.org/issue/34092: with an empty module cache,
...
            	09:16:49.774704 http.c:678              == Info: Failed sending HTTP2 data
            	09:16:49.774728 http.c:678              == Info: LibreSSL SSL_write: error:02FFF020:system library:func(4095):Broken pipe, errno 32
            	09:16:49.774732 http.c:678              == Info: Failed sending HTTP2 data
            	09:16:49.774754 http.c:678              == Info: Closing connection 0
            	error: RPC failed; curl 55 LibreSSL SSL_write: error:02FFF020:system library:func(4095):Broken pipe, errno 32
            	error: 4075 bytes of body are still expected
            	fetch-pack: unexpected disconnect while reading sideband packet
            	fatal: early EOF
            	fatal: fetch-pack: invalid index-pack output
        script_test.go:160: FAIL: testdata/script/mod_get_direct.txt:12: go list -m cloud.google.com/go@main: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-03-21 11:49 darwin-amd64-longtest go@cff7267e cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:49929
https://vcs-test.golang.org rerouted to https://127.0.0.1:49930
go test proxy running at GOPROXY=http://127.0.0.1:49931/mod
2024/03/21 09:00:12 http: TLS handshake error from 127.0.0.1:51164: read tcp 127.0.0.1:49930->127.0.0.1:51164: read: connection reset by peer
2024/03/21 09:00:12 http: TLS handshake error from 127.0.0.1:51165: read tcp 127.0.0.1:49930->127.0.0.1:51165: read: connection reset by peer
--- FAIL: TestScript (0.78s)
    --- FAIL: TestScript/mod_get_direct (122.50s)
        script_test.go:136: 2024-03-21T13:00:28Z
        script_test.go:138: $WORK=/tmp/buildlet/tmp/cmd-go-test-1288209356/tmpdir3608272145/mod_get_direct920031510
        script_test.go:160: 
...
            	09:02:30.827983 http.c:678              == Info: Failed sending HTTP2 data
            	09:02:30.828011 http.c:678              == Info: LibreSSL SSL_write: error:02FFF020:system library:func(4095):Broken pipe, errno 32
            	09:02:30.828015 http.c:678              == Info: Failed sending HTTP2 data
            	09:02:30.828037 http.c:678              == Info: Closing connection 0
            	error: RPC failed; curl 55 LibreSSL SSL_write: error:02FFF020:system library:func(4095):Broken pipe, errno 32
            	error: 3586 bytes of body are still expected
            	fetch-pack: unexpected disconnect while reading sideband packet
            	fatal: early EOF
            	fatal: fetch-pack: invalid index-pack output
        script_test.go:160: FAIL: testdata/script/mod_get_direct.txt:12: go list -m cloud.google.com/go@main: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-03-15 15:59 linux-arm64-longtest mod@aa51b25a go@979b34b3 x/mod/zip.TestVCS (log) 
--- FAIL: TestVCS (0.00s)
    --- FAIL: TestVCS/[email protected] (2.55s)
        zip_test.go:1328: /usr/bin/git init --bare
        zip_test.go:1345: /usr/bin/git remote add origin -- https://go.googlesource.com/blog
        zip_test.go:1354: exit status 128: /usr/bin/git fetch -f --depth=1 origin 0cd0cdff05c251ad0c796cc94d7059e013311fc6:refs/dummy
            17:59:41.705624 http.c:756              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults
            17:59:41.709876 http.c:756              == Info:   Trying 142.251.180.82:443...
            17:59:41.710325 http.c:756              == Info: Connected to go.googlesource.com (142.251.180.82) port 443 (#0)
            17:59:41.743020 http.c:756              == Info: found 387 certificates in /etc/ssl/certs
            17:59:41.743085 http.c:756              == Info: ALPN, offering h2
...
            17:59:44.072752 http.c:756              == Info: Failed receiving HTTP2 data
            i�
            17:59:44.072760 http.c:756              == Info: Failed sending HTTP2 data
            17:59:44.072767 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            error: RPC failed; curl 56 GnuTLS recv error (-54): Error in the pull function.
            error: 12580 bytes of body are still expected
            fetch-pack: unexpected disconnect while reading sideband packet
            fatal: early EOF
            fatal: index-pack failed
        zip_test.go:1223: failed to download zip from repository (repeated failure): exit status 128

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-03-26 19:58 gotip-darwin-amd64-longtest go@1e12eab8 cmd/go.TestScript/mod_get_direct (log) 
=== RUN   TestScript/mod_get_direct
=== PAUSE TestScript/mod_get_direct
=== CONT  TestScript/mod_get_direct
    script_test.go:136: 2024-03-27T02:40:48Z
    script_test.go:138: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-629117639/tmpdir1690848268/mod_get_direct365788876
go proxy: open /Users/swarming/.swarming/w/ir/x/w/goroot/src/cmd/go/testdata/mod/rsc.io_v1.4.0.txt: no such file or directory
go proxy: no archive rsc.io v1.4.0: file does not exist
go proxy: no archive rsc.io v1.0.0: file does not exist
    script_test.go:160: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-629117639/tmpdir1690848268/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
...
        	19:41:20.370041 http.c:658              <= Recv header:
        	19:43:49.389738 http.c:699              == Info: transfer closed with outstanding read data remaining
        	19:43:49.389822 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 2529 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:160: FAIL: testdata/script/mod_get_direct.txt:12: go list -m cloud.google.com/go@main: exit status 1
--- FAIL: TestScript/mod_get_direct (180.77s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-04-30 12:44 gotip-linux-amd64-longtest-race go@dc164ead cmd/go/internal/modfetch.TestCodeRepo/golang.org_x_text/4e4a3210bb (log) 
=== RUN   TestCodeRepo/golang.org_x_text/4e4a3210bb
=== PAUSE TestCodeRepo/golang.org_x_text/4e4a3210bb
=== CONT  TestCodeRepo/golang.org_x_text/4e4a3210bb
    coderepo_test.go:623: repo.Stat("4e4a3210bb"): golang.org/x/text@4e4a3210bb: invalid version: git fetch -f origin refs/heads/*:refs/heads/* refs/tags/*:refs/tags/* in /home/swarming/.swarming/w/ir/x/t/gitrepo-test-627145074/modcache/cache/vcs/38515699458adac9c8b61a0b44f9ad7a5f6edd7bcc2d7fae95930ec78f71e1b4: exit status 128:
        	error: RPC failed; curl 56 OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
        	error: 59366 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
--- FAIL: TestCodeRepo/golang.org_x_text/4e4a3210bb (3.94s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-05-06 21:03 go1.21-linux-arm64-longtest release-branch.go1.21@78d89b2b cmd/go.TestScript/mod_sumdb_golang (log) 
=== RUN   TestScript/mod_sumdb_golang
=== PAUSE TestScript/mod_sumdb_golang
=== CONT  TestScript/mod_sumdb_golang
    script_test.go:132: 2024-05-06T21:14:01Z
    script_test.go:134: $WORK=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-1432017397/tmpdir3660108477/mod_sumdb_golang4117180452
go proxy: no archive rsc.io v1.0.0: file does not exist
2024/05/06 21:14:01 serving /git/hello/info/refs?service=git-upload-pack
2024/05/06 21:14:01 serving /git/hello/git-upload-pack
go proxy: no archive rsc.io v1.0.0: file does not exist
go proxy: no archive rsc.io v1.0.0: file does not exist
...
        	21:14:07.641526 http.c:699              == Info: OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
        	21:14:07.641533 http.c:699              == Info: Closing connection 0
        	21:14:07.641541 http.c:699              == Info: TLSv1.3 (OUT), TLS Unknown, Unknown (21):
        	error: RPC failed; curl 56 OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
        	error: 57182 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:156: FAIL: testdata/script/mod_sumdb_golang.txt:20: go get rsc.io/[email protected]: exit status 1
--- FAIL: TestScript/mod_sumdb_golang (6.13s)
2024-05-07 15:21 gotip-linux-386-longtest go@38ee0c76 cmd/go.TestScript/mod_sumdb_golang (log) 
=== RUN   TestScript/mod_sumdb_golang
=== PAUSE TestScript/mod_sumdb_golang
=== CONT  TestScript/mod_sumdb_golang
    script_test.go:135: 2024-05-07T15:37:22Z
    script_test.go:137: $WORK=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-3846653928/tmpdir2848863614/mod_sumdb_golang2793833085
    script_test.go:159: 
        PATH=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-3846653928/tmpdir2848863614/testbin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/cache/tools/bin:/home/swarming/.swarming/w/ir/bbagent_utility_packages:/home/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages:/home/swarming/.swarming/w/ir/cipd_bin_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/home/swarming/.swarming/w/ir/cache/cipd_client:/home/swarming/.swarming/w/ir/cache/cipd_client/bin:/home/swarming/.swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=386
...
        	15:37:48.857668 http.c:699              == Info: OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
        	15:37:48.857679 http.c:699              == Info: Closing connection 0
        	15:37:48.857696 http.c:699              == Info: TLSv1.3 (OUT), TLS Unknown, Unknown (21):
        	error: RPC failed; curl 56 OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
        	error: 23870 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_sumdb_golang.txt:71: go list -mod=mod -x -m all: exit status 1
--- FAIL: TestScript/mod_sumdb_golang (27.89s)
2024-05-07 18:38 gotip-linux-arm64-longtest go@008cc58a cmd/go.TestScript/mod_invalid_version (log) 
=== RUN   TestScript/mod_invalid_version
=== PAUSE TestScript/mod_invalid_version
=== CONT  TestScript/mod_invalid_version
    script_test.go:135: 2024-05-07T18:49:52Z
    script_test.go:137: $WORK=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-878626270/tmpdir841534478/mod_invalid_version1362648764
go proxy: no archive example.com/c v0.1.0: file does not exist
go proxy: no archive example.com v0.1.0: file does not exist
go proxy: open /home/swarming/.swarming/w/ir/x/w/goroot/src/cmd/go/testdata/mod/example.com_b_v0.1.0.txt: no such file or directory
go proxy: no archive example.com/b v0.1.0: file does not exist
go proxy: no archive example.com/b v0.3.0: file does not exist
...
        	18:49:58.060801 http.c:699              == Info: OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
        	18:49:58.060809 http.c:699              == Info: Closing connection 0
        	18:49:58.060817 http.c:699              == Info: TLSv1.3 (OUT), TLS Unknown, Unknown (21):
        	error: RPC failed; curl 56 OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
        	error: 41774 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_invalid_version.txt:24: go list -m golang.org/x/text: exit status 1
--- FAIL: TestScript/mod_invalid_version (5.39s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-05-09 22:43 linux-amd64-longtest go@e0aab32c cmd/go.TestScript (log) 
vcs-test.golang.org rerouted to http://127.0.0.1:45971
https://vcs-test.golang.org rerouted to https://127.0.0.1:35847
go test proxy running at GOPROXY=http://127.0.0.1:39009/mod
2024/05/09 23:11:04 http: TLS handshake error from 127.0.0.1:56580: read tcp 127.0.0.1:35847->127.0.0.1:56580: read: connection reset by peer
2024/05/09 23:11:04 http: TLS handshake error from 127.0.0.1:56554: EOF
2024/05/09 23:11:20 http: TLS handshake error from 127.0.0.1:43026: EOF
--- FAIL: TestScript (0.06s)
    --- FAIL: TestScript/mod_invalid_version (3.43s)
        script_test.go:135: 2024-05-09T23:10:43Z
        script_test.go:137: $WORK=/workdir/tmp/cmd-go-test-2360837432/tmpdir1246506034/mod_invalid_version758432839
...
            	23:10:46.928947 http.c:756              == Info: Failed receiving HTTP2 data
            	��
            	23:10:46.928958 http.c:756              == Info: Failed sending HTTP2 data
            	23:10:46.928968 http.c:756              == Info: Connection #0 to host go.googlesource.com left intact
            	error: RPC failed; curl 56 GnuTLS recv error (-54): Error in the pull function.
            	error: 55334 bytes of body are still expected
            	fetch-pack: unexpected disconnect while reading sideband packet
            	fatal: early EOF
            	fatal: index-pack failed
        script_test.go:159: FAIL: testdata/script/mod_invalid_version.txt:24: go list -m golang.org/x/text: exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-05-10 15:28 go1.21-linux-386-longtest release-branch.go1.21@77cfa290 cmd/go.TestScript/get_with_git_trace (log) 
=== RUN   TestScript/get_with_git_trace
=== PAUSE TestScript/get_with_git_trace
=== CONT  TestScript/get_with_git_trace
    script_test.go:132: 2024-05-10T15:43:19Z
    script_test.go:134: $WORK=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-4012683735/tmpdir735087175/get_with_git_trace2635255352
    script_test.go:156: 
        PATH=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-4012683735/tmpdir735087175/testbin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/cache/tools/bin:/home/swarming/.swarming/w/ir/bbagent_utility_packages:/home/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages:/home/swarming/.swarming/w/ir/cipd_bin_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/home/swarming/.swarming/w/ir/cache/cipd_client:/home/swarming/.swarming/w/ir/cache/cipd_client/bin:/home/swarming/.swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=386
...
        15:43:22.853698 http.c:699              == Info: Closing connection 0
        15:43:22.853713 http.c:699              == Info: TLSv1.3 (OUT), TLS Unknown, Unknown (21):
        error: RPC failed; curl 56 OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
        error: 41718 bytes of body are still expected
        fetch-pack: unexpected disconnect while reading sideband packet
        fatal: early EOF
        fatal: fetch-pack: invalid index-pack output
        package golang.org/x/text: exit status 128
    script_test.go:156: FAIL: testdata/script/get_with_git_trace.txt:9: go get golang.org/x/text: exit status 1
--- FAIL: TestScript/get_with_git_trace (2.99s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-05-16 21:49 gotip-linux-amd64-longtest-race go@c8931866 cmd/go.TestScript/mod_pseudo_cache (log) 
=== RUN   TestScript/mod_pseudo_cache
=== PAUSE TestScript/mod_pseudo_cache
=== CONT  TestScript/mod_pseudo_cache
    script_test.go:135: 2024-05-16T22:03:56Z
    script_test.go:137: $WORK=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-1246222102/tmpdir1397032921/mod_pseudo_cache2649874648
    script_test.go:159: 
        PATH=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-1246222102/tmpdir1397032921/testbin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/cache/tools/bin:/home/swarming/.swarming/w/ir/bbagent_utility_packages:/home/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages:/home/swarming/.swarming/w/ir/cipd_bin_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/home/swarming/.swarming/w/ir/cache/cipd_client:/home/swarming/.swarming/w/ir/cache/cipd_client/bin:/home/swarming/.swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        [stdout]
        {
        	"Path": "golang.org/x/text",
        	"Version": "v0.0.0-20171215141712-a1b916ed6726",
        	"Error": "golang.org/x/[email protected]: invalid version: git fetch -f origin refs/heads/*:refs/heads/* refs/tags/*:refs/tags/* in /home/swarming/.swarming/w/ir/x/t/cmd-go-test-1246222102/tmpdir1397032921/mod_pseudo_cache2649874648/gopath/pkg/mod/cache/vcs/38515699458adac9c8b61a0b44f9ad7a5f6edd7bcc2d7fae95930ec78f71e1b4: exit status 128:\n\t22:03:58.306425 http.c:699              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t22:03:58.318668 http.c:699              == Info:   Trying 74.125.199.82...\n\t22:03:58.318765 http.c:699              == Info: TCP_NODELAY set\n\t22:03:58.319598 http.c:699              == Info: Connected to go.googlesource.com (74.125.199.82) port 443 (#0)\n\t22:03:58.320735 http.c:699              == Info: ALPN, offering http/1.1\n\t22:03:58.344479 http.c:699              == Info: successfully set certificate verify locations:\n\t  CAfile: /etc/ssl/certs/ca-certificates.crt\n\t  CApath: /usr/share/ca-certificates\n\t22:03:58.344778 http.c:699              == Info: TLSv1.3 (OUT), TLS handshake, Client hello (1):\n\t22:03:58.373549 http.c:699              == Info: TLSv1.3 (IN), TLS handshake, Server hello (2):\n\t22:03:58.373895 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Certificate Status (22):\n\t22:03:58.373955 http.c:699              == Info: TLSv1.3 (IN), TLS handshake, Unknown (8):\n\t22:03:58.374007 http.c:699              == Info: TLSv1.3 (IN), TLS handshake, Certificate (11):\n\t22:03:58.374826 http.c:699              == Info: TLSv1.3 (IN), TLS handshake, CERT verify (15):\n\t22:03:58.375157 http.c:699              == Info: TLSv1.3 (IN), TLS handshake, Finished (20):\n\t22:03:58.375301 http.c:699              == Info: TLSv1.3 (OUT), TLS change cipher, Client hello (1):\n\t22:03:58.375393 http.c:699              == Info: TLSv1.3 (OUT), TLS Unknown, Certificate Status (22):\n\t22:03:58.375443 http.c:699              == Info: TLSv1.3 (OUT), TLS handshake, Finished (20):\n\t22:03:58.375634 http.c:699              == Info: SSL connection using TLSv1.3 / TLS_AES_256_GCM_SHA384\n\t22:03:58.375689 http.c:699              == Info: ALPN, server accepted to use http/1.1\n\t22:03:58.375723 http.c:699              == Info: Server certificate:\n\t22:03:58.375772 http.c:699              == Info:  subject: CN=*.googlecode.com\n\t22:03:58.375817 http.c:699              == Info:  start date: May  6 14:37:28 2024 GMT\n\t22:03:58.375845 http.c:699              == Info:  expire date: Jul 29 14:37:27 2024 GMT\n\t22:03:58.375907 http.c:699              == Info:  subjectAltName: host \"go.googlesource.com\" matched cert's \"*.googlesource.com\"\n\t22:03:58.375958 http.c:699              == Info:  issuer: C=US; O=Google Trust Services LLC; CN=GTS CA 1C3\n\t22:03:58.375986 http.c:699              == Info:  SSL certificate verify ok.\n\t22:03:58.376055 http.c:699              == Info: TLSv1.3 (OUT), TLS Unknown, Unknown (23):\n\t22:03:58.376144 http.c:646              =\u003e Send header, 0000000207 bytes (0x000000cf)\n\t22:03:58.376190 http.c:658              =\u003e Send header: GET /text/info/refs?service=git-upload-pack HTTP/1.1\n\t22:03:58.376224 http.c:658              =\u003e Send header: Host: go.googlesource.com\n\t22:03:58.376253 http.c:658              =\u003e Send header: User-Agent: git/2.39.2.chromium.11\n\t22:03:58.376338 http.c:658              =\u003e Send header: Accept: */*\n\t22:03:58.376372 http.c:658              =\u003e Send header: Accept-Encoding: deflate, gzip\n\t22:03:58.376396 http.c:658              =\u003e Send header: Pragma: no-cache\n\t22:03:58.376416 http.c:658              =\u003e Send header: Git-Protocol: version=2\n\t22:03:58.376434 http.c:658              =\u003e Send header:\n\t22:03:58.636121 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.636155 http.c:646              \u003c= Recv header, 0000000017 bytes (0x00000011)\n\t22:03:58.636162 http.c:658              \u003c= Recv header: HTTP/1.1 200 OK\n\t22:03:58.636168 http.c:646              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t22:03:58.636172 http.c:658              \u003c= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate\n\t22:03:58.636178 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t22:03:58.636182 http.c:658              \u003c= Recv header: Content-Length: 151\n\t22:03:58.636187 http.c:646              \u003c= Recv header, 0000000059 bytes (0x0000003b)\n\t22:03:58.636190 http.c:658              \u003c= Recv header: Content-Type: application/x-git-upload-pack-advertisement\n\t22:03:58.636195 http.c:646              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t22:03:58.636199 http.c:658              \u003c= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t22:03:58.636202 http.c:646              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t22:03:58.636206 http.c:658              \u003c= Recv header: Pragma: no-cache\n\t22:03:58.636210 http.c:646              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t22:03:58.636214 http.c:658              \u003c= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains; preload\n\t22:03:58.636219 http.c:646              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t22:03:58.636223 http.c:658              \u003c= Recv header: X-Content-Type-Options: nosniff\n\t22:03:58.636227 http.c:646              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t22:03:58.636230 http.c:658              \u003c= Recv header: X-Frame-Options: SAMEORIGIN\n\t22:03:58.636235 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t22:03:58.636238 http.c:658              \u003c= Recv header: X-Xss-Protection: 0\n\t22:03:58.636242 http.c:646              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t22:03:58.636246 http.c:658              \u003c= Recv header: Date: Thu, 16 May 2024 22:03:58 GMT\n\t22:03:58.636250 http.c:646              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t22:03:58.636253 http.c:658              \u003c= Recv header:\n\t22:03:58.636267 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact\n\t22:03:58.636620 http.c:699              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t22:03:58.636639 http.c:699              == Info: Found bundle for host go.googlesource.com: 0xc50b10 [can pipeline]\n\t22:03:58.636653 http.c:699              == Info: Re-using existing connection! (#0) with host go.googlesource.com\n\t22:03:58.636661 http.c:699              == Info: Connected to go.googlesource.com (74.125.199.82) port 443 (#0)\n\t22:03:58.636701 http.c:699              == Info: TLSv1.3 (OUT), TLS Unknown, Unknown (23):\n\t22:03:58.636750 http.c:646              =\u003e Send header, 0000000279 bytes (0x00000117)\n\t22:03:58.636758 http.c:658              =\u003e Send header: POST /text/git-upload-pack HTTP/1.1\n\t22:03:58.636762 http.c:658              =\u003e Send header: Host: go.googlesource.com\n\t22:03:58.636765 http.c:658              =\u003e Send header: User-Agent: git/2.39.2.chromium.11\n\t22:03:58.636769 http.c:658              =\u003e Send header: Accept-Encoding: deflate, gzip\n\t22:03:58.636772 http.c:658              =\u003e Send header: Content-Type: application/x-git-upload-pack-request\n\t22:03:58.636776 http.c:658              =\u003e Send header: Accept: application/x-git-upload-pack-result\n\t22:03:58.636780 http.c:658              =\u003e Send header: Git-Protocol: version=2\n\t22:03:58.636784 http.c:658              =\u003e Send header: Content-Length: 128\n\t22:03:58.636787 http.c:658              =\u003e Send header:\n\t22:03:58.636800 http.c:699              == Info: upload completely sent off: 128 out of 128 bytes\n\t22:03:58.693144 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.693185 http.c:646              \u003c= Recv header, 0000000017 bytes (0x00000011)\n\t22:03:58.693192 http.c:658              \u003c= Recv header: HTTP/1.1 200 OK\n\t22:03:58.693198 http.c:646              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t22:03:58.693202 http.c:658              \u003c= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate\n\t22:03:58.693208 http.c:646              \u003c= Recv header, 0000000052 bytes (0x00000034)\n\t22:03:58.693211 http.c:658              \u003c= Recv header: Content-Type: application/x-git-upload-pack-result\n\t22:03:58.693215 http.c:646              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t22:03:58.693219 http.c:658              \u003c= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t22:03:58.693223 http.c:646              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t22:03:58.693228 http.c:658              \u003c= Recv header: Pragma: no-cache\n\t22:03:58.693232 http.c:646              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t22:03:58.693236 http.c:658              \u003c= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains; preload\n\t22:03:58.693241 http.c:646              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t22:03:58.693245 http.c:658              \u003c= Recv header: X-Content-Type-Options: nosniff\n\t22:03:58.693249 http.c:646              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t22:03:58.693252 http.c:658              \u003c= Recv header: X-Frame-Options: SAMEORIGIN\n\t22:03:58.693256 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t22:03:58.693260 http.c:658              \u003c= Recv header: X-Xss-Protection: 0\n\t22:03:58.693264 http.c:646              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t22:03:58.693267 http.c:658              \u003c= Recv header: Date: Thu, 16 May 2024 22:03:58 GMT\n\t22:03:58.693272 http.c:646              \u003c= Recv header, 0000000028 bytes (0x0000001c)\n\t22:03:58.693275 http.c:658              \u003c= Recv header: Transfer-Encoding: chunked\n\t22:03:58.693279 http.c:646              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t22:03:58.693283 http.c:658              \u003c= Recv header:\n\t22:03:58.693321 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.693346 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.693370 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.696274 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.696305 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact\n\t22:03:58.699470 http.c:699              == Info: Couldn't find host go.googlesource.com in the .netrc file; using defaults\n\t22:03:58.699493 http.c:699              == Info: Found bundle for host go.googlesource.com: 0xc50b10 [can pipeline]\n\t22:03:58.699508 http.c:699              == Info: Re-using existing connection! (#0) with host go.googlesource.com\n\t22:03:58.699516 http.c:699              == Info: Connected to go.googlesource.com (74.125.199.82) port 443 (#0)\n\t22:03:58.699558 http.c:699              == Info: TLSv1.3 (OUT), TLS Unknown, Unknown (23):\n\t22:03:58.699641 http.c:646              =\u003e Send header, 0000000303 bytes (0x0000012f)\n\t22:03:58.699651 http.c:658              =\u003e Send header: POST /text/git-upload-pack HTTP/1.1\n\t22:03:58.699655 http.c:658              =\u003e Send header: Host: go.googlesource.com\n\t22:03:58.699659 http.c:658              =\u003e Send header: User-Agent: git/2.39.2.chromium.11\n\t22:03:58.699662 http.c:658              =\u003e Send header: Accept-Encoding: deflate, gzip\n\t22:03:58.699666 http.c:658              =\u003e Send header: Content-Type: application/x-git-upload-pack-request\n\t22:03:58.699669 http.c:658              =\u003e Send header: Accept: application/x-git-upload-pack-result\n\t22:03:58.699673 http.c:658              =\u003e Send header: Git-Protocol: version=2\n\t22:03:58.699677 http.c:658              =\u003e Send header: Content-Encoding: gzip\n\t22:03:58.699680 http.c:658              =\u003e Send header: Content-Length: 267\n\t22:03:58.699683 http.c:658              =\u003e Send header:\n\t22:03:58.699690 http.c:699              == Info: upload completely sent off: 267 out of 267 bytes\n\t22:03:58.901894 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.901932 http.c:646              \u003c= Recv header, 0000000017 bytes (0x00000011)\n\t22:03:58.901939 http.c:658              \u003c= Recv header: HTTP/1.1 200 OK\n\t22:03:58.901944 http.c:646              \u003c= Recv header, 0000000053 bytes (0x00000035)\n\t22:03:58.901948 http.c:658              \u003c= Recv header: Cache-Control: no-cache, max-age=0, must-revalidate\n\t22:03:58.901954 http.c:646              \u003c= Recv header, 0000000052 bytes (0x00000034)\n\t22:03:58.901957 http.c:658              \u003c= Recv header: Content-Type: application/x-git-upload-pack-result\n\t22:03:58.901961 http.c:646              \u003c= Recv header, 0000000040 bytes (0x00000028)\n\t22:03:58.901965 http.c:658              \u003c= Recv header: Expires: Fri, 01 Jan 1980 00:00:00 GMT\n\t22:03:58.901969 http.c:646              \u003c= Recv header, 0000000018 bytes (0x00000012)\n\t22:03:58.901973 http.c:658              \u003c= Recv header: Pragma: no-cache\n\t22:03:58.901977 http.c:646              \u003c= Recv header, 0000000073 bytes (0x00000049)\n\t22:03:58.901982 http.c:658              \u003c= Recv header: Strict-Transport-Security: max-age=31536000; includeSubDomains; preload\n\t22:03:58.901986 http.c:646              \u003c= Recv header, 0000000033 bytes (0x00000021)\n\t22:03:58.901990 http.c:658              \u003c= Recv header: X-Content-Type-Options: nosniff\n\t22:03:58.901994 http.c:646              \u003c= Recv header, 0000000029 bytes (0x0000001d)\n\t22:03:58.901997 http.c:658              \u003c= Recv header: X-Frame-Options: SAMEORIGIN\n\t22:03:58.902001 http.c:646              \u003c= Recv header, 0000000021 bytes (0x00000015)\n\t22:03:58.902004 http.c:658              \u003c= Recv header: X-Xss-Protection: 0\n\t22:03:58.902008 http.c:646              \u003c= Recv header, 0000000037 bytes (0x00000025)\n\t22:03:58.902012 http.c:658              \u003c= Recv header: Date: Thu, 16 May 2024 22:03:58 GMT\n\t22:03:58.902016 http.c:646              \u003c= Recv header, 0000000028 bytes (0x0000001c)\n\t22:03:58.902020 http.c:658              \u003c= Recv header: Transfer-Encoding: chunked\n\t22:03:58.902024 http.c:646              \u003c= Recv header, 0000000002 bytes (0x00000002)\n\t22:03:58.902028 http.c:658              \u003c= Recv header:\n\t22:03:58.902065 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.902089 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.903709 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.903756 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.903779 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.909684 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.909753 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.909785 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.909815 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.909856 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.909885 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.909913 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.909941 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.909970 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.909998 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.910028 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.910061 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.912349 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.912407 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.912437 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.912465 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.912491 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.912517 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.912544 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.912570 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.912618 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.915183 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.915244 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.915277 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941457 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941510 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941536 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941563 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941604 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941635 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941667 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941698 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941726 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941760 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941790 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941819 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.941856 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.954208 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.954275 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.954309 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.954339 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.954369 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.954399 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.954427 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.954458 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.954490 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.955508 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.955546 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.955592 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.955619 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.959682 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.959728 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.959752 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.959779 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.959804 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.959830 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.959867 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.959891 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.959916 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.962315 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.962370 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.962404 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.984333 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.984397 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.984429 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.984459 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.984489 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.984517 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.984546 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.984588 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.984623 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.985008 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.985042 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.985076 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.985106 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.988490 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.988609 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.988642 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.988671 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.988699 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.988728 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.988755 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.988782 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.988809 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.988961 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.989073 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.989230 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.989334 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.991724 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.991775 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.991799 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.991824 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.991848 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.991871 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.991894 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.991917 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.991949 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.991979 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.992003 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.992029 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:58.992071 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000291 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000373 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000398 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000422 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000444 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000468 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000490 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000513 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000536 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000562 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000585 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000626 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000649 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000671 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000694 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000716 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000738 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000761 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000783 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000805 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000827 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000850 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000882 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000905 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000929 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.000950 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003140 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003193 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003218 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003242 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003265 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003289 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003311 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003335 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003358 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003384 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003407 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003431 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.003453 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.007690 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.007826 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.007907 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.007943 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.007968 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.007991 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008015 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008038 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008062 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008088 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008112 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008137 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008160 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008182 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008204 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008228 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008251 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008274 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008297 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008319 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008343 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008366 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008391 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008414 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008438 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.008460 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.010467 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.010510 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.010535 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.010560 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.010600 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.010624 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.010647 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.010670 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.010694 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.011985 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.012027 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.012051 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015333 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015374 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015400 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015424 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015446 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015469 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015491 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015513 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015535 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015561 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015600 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015625 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.015646 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027697 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027761 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027786 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027811 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027835 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027859 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027882 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027905 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027928 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027955 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.027978 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028004 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028027 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028049 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028072 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028095 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028121 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028145 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028169 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028191 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028214 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028237 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028261 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028284 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028308 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028329 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028938 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.028989 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029013 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029038 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029060 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029084 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029106 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029130 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029153 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029178 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029201 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029226 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.029247 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.033665 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.033736 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.033770 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.033801 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.033832 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.033862 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.033893 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.033923 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.033954 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.033984 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.034016 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.034049 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.034427 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.034472 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.034549 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.034633 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.034712 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.034790 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.034876 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.034959 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.035033 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.035678 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.035763 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.035833 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.037080 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.037182 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.037254 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.037318 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.037393 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.037457 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.037522 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.037601 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.037667 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.038392 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.038483 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.038552 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.039761 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.039858 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.039933 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.039998 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.040064 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.040127 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.040197 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.040259 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.040325 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.040683 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.040764 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.040836 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.041816 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.041910 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.041984 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.042050 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.042116 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.042176 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.042242 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.042302 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.042376 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.042870 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.043002 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.043077 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.043139 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.045018 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.045114 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.045205 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.045267 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.050960 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051011 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051040 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051070 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051097 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051129 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051155 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051186 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051213 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051240 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051267 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051295 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051321 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051350 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051377 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051406 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051470 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051513 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051541 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051568 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051618 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051647 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051676 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051704 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051731 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051768 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051796 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051822 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051849 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051878 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051906 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051933 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051962 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.051989 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052016 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052043 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052070 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052098 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052130 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052158 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052186 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052212 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052374 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052530 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052562 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052613 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052643 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.052673 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055219 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055281 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055311 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055337 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055364 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055391 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055418 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055446 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055473 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055500 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055527 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055555 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):\n\t22:03:59.055598
(... long comment truncated ...)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-07-30 23:08 gotip-linux-amd64_c3h88-perf_vs_release go@7299212a [build] (log) 
go: downloading github.com/BurntSushi/toml v1.0.0
go: downloading github.com/kballard/go-shellquote v0.0.0-20180428030007-95032a82bc51
2024/07/31 02:22:45 Load average: 5.38 1.26 0.41 2/992 4249
2024/07/31 02:22:45 Waiting for load average to drop below 0.20...
2024/07/31 02:23:15 Load average: 3.40 1.17 0.41 2/993 4249
2024/07/31 02:23:15 Waiting for load average to drop below 0.20...
2024/07/31 02:23:45 Load average: 2.06 1.05 0.40 2/992 4249
2024/07/31 02:23:45 Waiting for load average to drop below 0.20...
2024/07/31 02:24:15 Load average: 1.25 0.95 0.38 1/992 4249
2024/07/31 02:24:15 Waiting for load average to drop below 0.20...
...
[sweet] Running benchmark tile38 for experiment: run 8
[sweet] Running benchmark tile38 for baseline: run 8
[sweet] Running benchmark tile38 for experiment: run 9
[sweet] Running benchmark tile38 for baseline: run 9
[sweet] Running benchmark tile38 for experiment: run 10
[sweet] Running benchmark tile38 for baseline: run 10
[sweet] error: failed to execute benchmarks, see log for details
2024/07/31 08:12:01 Error running sweet: error running sweet run: exit status 1
2024/07/31 08:12:01 FAIL
exit status 1

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-08-16 23:34 gotip-darwin-amd64-longtest go@aa5d672a cmd/go.TestScript/mod_get_direct (log) 
=== RUN   TestScript/mod_get_direct
=== PAUSE TestScript/mod_get_direct
=== CONT  TestScript/mod_get_direct
    script_test.go:135: 2024-08-17T08:11:18Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-3643817703/tmpdir2759448538/mod_get_direct1885181235
    script_test.go:159: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-3643817703/tmpdir2759448538/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	01:11:41.979359 http.c:658              <= Recv header:
        	01:12:42.155230 http.c:699              == Info: transfer closed with outstanding read data remaining
        	01:12:42.156084 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 7892 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_get_direct.txt:12: go list -m cloud.google.com/go@main: exit status 1
--- FAIL: TestScript/mod_get_direct (83.64s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-08-19 13:46 gotip-darwin-amd64-longtest go@3d9a89b0 cmd/go.TestScript/mod_get_direct (log) 
=== RUN   TestScript/mod_get_direct
=== PAUSE TestScript/mod_get_direct
=== CONT  TestScript/mod_get_direct
go proxy: no archive rsc.io v1.5.2: file does not exist
go proxy: no archive rsc.io v1.0.0: file does not exist
    script_test.go:135: 2024-08-19T15:27:23Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-1113118865/tmpdir247280577/mod_get_direct2558419981
go proxy: no archive example.net/a v0.2.0: file does not exist
go proxy: no archive example.net v0.2.0: file does not exist
go proxy: open /Users/swarming/.swarming/w/ir/x/w/goroot/src/cmd/go/testdata/mod/example.net_b_v0.1.2.txt: no such file or directory
...
        	08:27:42.441909 http.c:658              <= Recv header:
        	08:28:29.832149 http.c:699              == Info: transfer closed with outstanding read data remaining
        	08:28:29.832365 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 6762 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_get_direct.txt:12: go list -m cloud.google.com/go@main: exit status 1
--- FAIL: TestScript/mod_get_direct (66.24s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-08-19 19:09 gotip-darwin-amd64-longtest go@d5f7da79 cmd/go.TestScript/mod_get_direct (log) 
=== RUN   TestScript/mod_get_direct
=== PAUSE TestScript/mod_get_direct
=== CONT  TestScript/mod_get_direct
    script_test.go:135: 2024-08-19T20:09:04Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-2104105899/tmpdir270593823/mod_get_direct4244126855
    script_test.go:159: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-2104105899/tmpdir270593823/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	13:09:23.364702 http.c:658              <= Recv header:
        	13:10:11.895469 http.c:699              == Info: transfer closed with outstanding read data remaining
        	13:10:11.895541 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 1195 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_get_direct.txt:12: go list -m cloud.google.com/go@main: exit status 1
--- FAIL: TestScript/mod_get_direct (67.55s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-08-22 13:19 gotip-linux-arm64-longtest go@c6f56985 cmd/go.TestScript/mod_gonoproxy (log) 
=== RUN   TestScript/mod_gonoproxy
=== PAUSE TestScript/mod_gonoproxy
=== CONT  TestScript/mod_gonoproxy
    script_test.go:135: 2024-08-22T13:35:04Z
    script_test.go:137: $WORK=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-2695471037/tmpdir3386688054/mod_gonoproxy909356355
    script_test.go:159: 
        PATH=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-2695471037/tmpdir3386688054/testbin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/cache/tools/bin:/home/swarming/.swarming/w/ir/bbagent_utility_packages:/home/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages:/home/swarming/.swarming/w/ir/cipd_bin_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/home/swarming/.swarming/w/ir/cache/cipd_client:/home/swarming/.swarming/w/ir/cache/cipd_client/bin:/home/swarming/.swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=arm64
...
        	13:35:14.444939 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):
        	13:35:14.444947 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):
        	13:35:16.410901 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):
        	13:35:16.410933 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact
        	error: 28144 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_gonoproxy.txt:51: go list -m all: exit status 1
--- FAIL: TestScript/mod_gonoproxy (12.31s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-08-22 20:04 gotip-darwin-amd64-longtest go@10ed134a cmd/go.TestScript/mod_sumdb_golang (log) 
=== RUN   TestScript/mod_sumdb_golang
=== PAUSE TestScript/mod_sumdb_golang
=== CONT  TestScript/mod_sumdb_golang
    script_test.go:135: 2024-08-22T21:39:22Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-810204883/tmpdir3608978189/mod_sumdb_golang2301380895
go proxy: no archive rsc.io v1.0.0: file does not exist
    script_test.go:159: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-810204883/tmpdir3608978189/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
        HOME=/no-home
        CCACHE_DISABLE=1
...
        	14:40:37.593014 http.c:658              <= Recv header: Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000
        	14:40:37.593030 http.c:646              <= Recv header, 0000000002 bytes (0x00000002)
        	14:40:37.593072 http.c:658              <= Recv header:
        	14:40:46.745519 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact
        	error: 10736 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_sumdb_golang.txt:71: go list -mod=mod -x -m all: exit status 1
--- FAIL: TestScript/mod_sumdb_golang (90.52s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-08-22 13:16 gotip-darwin-amd64-longtest go@1a7a8535 cmd/go.TestScript/mod_invalid_version (log) 
=== RUN   TestScript/mod_invalid_version
=== PAUSE TestScript/mod_invalid_version
=== CONT  TestScript/mod_invalid_version
    script_test.go:135: 2024-08-23T05:40:35Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-1823050942/tmpdir1855402918/mod_invalid_version2025325390
    script_test.go:159: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-1823050942/tmpdir1855402918/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	22:42:28.724295 http.c:658              <= Recv header:
        	22:43:22.686931 http.c:699              == Info: transfer closed with outstanding read data remaining
        	22:43:22.687133 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 4575 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_invalid_version.txt:187: go list -m github.com/pierrec/lz4: exit status 1
--- FAIL: TestScript/mod_invalid_version (168.94s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-08-27 14:27 gotip-darwin-amd64-longtest go@dff15aa6 cmd/go.TestScript/mod_get_direct (log) 
=== RUN   TestScript/mod_get_direct
=== PAUSE TestScript/mod_get_direct
=== CONT  TestScript/mod_get_direct
    script_test.go:135: 2024-08-27T15:54:25Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-995776407/tmpdir2165552535/mod_get_direct2994424399
    script_test.go:159: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-995776407/tmpdir2165552535/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	08:55:42.069997 http.c:658              <= Recv header:
        	08:57:10.590030 http.c:699              == Info: transfer closed with outstanding read data remaining
        	08:57:10.590123 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 7703 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_get_direct.txt:12: go list -m cloud.google.com/go@main: exit status 1
--- FAIL: TestScript/mod_get_direct (165.22s)
2024-08-27 14:27 gotip-darwin-amd64-longtest go@dff15aa6 cmd/go.TestScript/mod_invalid_version (log) 
=== RUN   TestScript/mod_invalid_version
=== PAUSE TestScript/mod_invalid_version
=== CONT  TestScript/mod_invalid_version
    script_test.go:135: 2024-08-27T15:52:43Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-995776407/tmpdir2165552535/mod_invalid_version3379635402
go proxy: no archive example.com/c v0.2.0: file does not exist
    script_test.go:159: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-995776407/tmpdir2165552535/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
        HOME=/no-home
        CCACHE_DISABLE=1
...
        	08:54:28.313068 http.c:658              <= Recv header:
        	08:55:24.463458 http.c:699              == Info: transfer closed with outstanding read data remaining
        	08:55:24.463518 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 2969 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_invalid_version.txt:187: go list -m github.com/pierrec/lz4: exit status 1
--- FAIL: TestScript/mod_invalid_version (161.49s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-09-04 16:06 gotip-darwin-amd64-longtest go@1b4cf43e cmd/go.TestScript/mod_get_direct (log) 
=== RUN   TestScript/mod_get_direct
=== PAUSE TestScript/mod_get_direct
=== CONT  TestScript/mod_get_direct
    script_test.go:135: 2024-09-04T17:31:48Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-784341203/tmpdir3453809487/mod_get_direct624488111
    script_test.go:159: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-784341203/tmpdir3453809487/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	10:32:41.056470 http.c:658              <= Recv header:
        	10:39:01.675364 http.c:699              == Info: transfer closed with outstanding read data remaining
        	10:39:01.675485 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 6986 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_get_direct.txt:12: go list -m cloud.google.com/go@main: exit status 1
--- FAIL: TestScript/mod_get_direct (433.28s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-09-12 15:45 gotip-darwin-amd64-longtest go@7a5fc9b3 cmd/go.TestScript/mod_get_direct (log) 
=== RUN   TestScript/mod_get_direct
=== PAUSE TestScript/mod_get_direct
=== CONT  TestScript/mod_get_direct
    script_test.go:135: 2024-09-12T17:13:55Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-2144550937/tmpdir2356429096/mod_get_direct2205018741
go proxy: no archive rsc.io v1.5.1: file does not exist
go proxy: no archive rsc.io v1.0.0: file does not exist
go proxy: no archive rsc.io v1.5.2: file does not exist
go proxy: open /Users/swarming/.swarming/w/ir/x/w/goroot/src/cmd/go/testdata/mod/rsc.io_v1.4.0.txt: no such file or directory
go proxy: no archive rsc.io v1.4.0: file does not exist
...
        	10:23:02.965298 http.c:658              <= Recv header:
        	11:15:01.809862 http.c:699              == Info: transfer closed with outstanding read data remaining
        	11:15:01.809978 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 5144 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_get_direct.txt:12: go list -m cloud.google.com/go@main: exit status 1
--- FAIL: TestScript/mod_get_direct (3666.25s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-09-17 20:44 gotip-darwin-amd64-longtest go@b049837d cmd/go.TestScript/mod_invalid_version (log) 
=== RUN   TestScript/mod_invalid_version
=== PAUSE TestScript/mod_invalid_version
=== CONT  TestScript/mod_invalid_version
    script_test.go:135: 2024-09-17T22:21:20Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-413144188/tmpdir1444210132/mod_invalid_version687153796
    script_test.go:159: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-413144188/tmpdir1444210132/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	15:23:30.401622 http.c:658              <= Recv header:
        	15:31:12.352043 http.c:699              == Info: transfer closed with outstanding read data remaining
        	15:31:12.352097 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 380 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_invalid_version.txt:187: go list -m github.com/pierrec/lz4: exit status 1
--- FAIL: TestScript/mod_invalid_version (592.51s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-09-18 16:23 gotip-windows-amd64-longtest go@db40d1a4 cmd/go.TestScript/mod_sumdb_golang (log) 
=== RUN   TestScript/mod_sumdb_golang
=== PAUSE TestScript/mod_sumdb_golang
=== CONT  TestScript/mod_sumdb_golang
    script_test.go:135: 2024-09-18T16:38:07Z
    script_test.go:137: $WORK=C:\b\s\w\ir\x\t\cmd-go-test-1118896347\tmpdir753861501\mod_sumdb_golang1042410939
    script_test.go:159: 
        PATH=C:\b\s\w\ir\x\t\cmd-go-test-1118896347\tmpdir753861501\testbin;C:\b\s\w\ir\x\w\goroot\bin;C:\b\s\w\ir\x\w\goroot\bin;C:\b\s\w\ir\x\w\goroot\bin;C:\b\s\w\ir\cache\tools\bin;C:\b\s\w\ir\bbagent_utility_packages;C:\b\s\w\ir\bbagent_utility_packages\bin;C:\b\s\w\ir\cipd_bin_packages;C:\b\s\w\ir\cipd_bin_packages\bin;C:\b\s\w\ir\cipd_bin_packages\cpython3;C:\b\s\w\ir\cipd_bin_packages\cpython3\bin;C:\b\s\w\ir\cache\cipd_client;C:\b\s\w\ir\cache\cipd_client\bin;C:\b\s\cipd_cache\bin;C:\Program Files\OpenSSH\;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Windows\System32\OpenSSH\;C:\Program Files\Puppet Labs\Puppet\bin;C:\b\s\w\ir\cache\tools\cc\windows\gcc64\bin
        USERPROFILE=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	09:38:20.311814 http.c:683              <= Recv header: date: Wed, 18 Sep 2024 16:38:19 GMT
        	09:38:20.311814 http.c:671              <= Recv header, 0000000002 bytes (0x00000002)
        	09:38:20.311814 http.c:683              <= Recv header:
        	09:38:22.782553 http.c:724              == Info: Connection #1 to host go.googlesource.com left intact
        	error: 11248 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata\script\mod_sumdb_golang.txt:20: go get rsc.io/[email protected]: exit status 1
--- FAIL: TestScript/mod_sumdb_golang (17.07s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-10-07 17:51 gotip-darwin-amd64-longtest go@1a955f5c cmd/go.TestScript/mod_invalid_version (log) 
=== RUN   TestScript/mod_invalid_version
=== PAUSE TestScript/mod_invalid_version
=== CONT  TestScript/mod_invalid_version
    script_test.go:139: 2024-10-08T07:09:39Z
    script_test.go:141: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-1823320888/tmpdir1363191438/mod_invalid_version3594770961
    script_test.go:163: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-1823320888/tmpdir1363191438/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	00:13:35.543903 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 448 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:163: FAIL: testdata/script/mod_invalid_version.txt:187: go list -m github.com/pierrec/lz4: exit status 1
go proxy: no archive example.net v0.1.0: file does not exist
go proxy: no archive example.net/c v0.1.0: file does not exist
--- FAIL: TestScript/mod_invalid_version (236.80s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-10-07 15:33 gotip-darwin-amd64-longtest go@534d6a1a cmd/go.TestScript/mod_get_direct (log) 
=== RUN   TestScript/mod_get_direct
=== PAUSE TestScript/mod_get_direct
=== CONT  TestScript/mod_get_direct
    script_test.go:139: 2024-10-08T21:52:59Z
    script_test.go:141: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-3420354627/tmpdir3535011985/mod_get_direct1603733950
go proxy: no archive rsc.io v1.5.1: file does not exist
go proxy: no archive rsc.io v1.0.0: file does not exist
go proxy: no archive rsc.io v1.5.2: file does not exist
go proxy: no archive rsc.io v1.0.0: file does not exist
go proxy: open /Users/swarming/.swarming/w/ir/x/w/goroot/src/cmd/go/testdata/mod/rsc.io_v1.4.0.txt: no such file or directory
...
        	14:55:24.070784 http.c:658              <= Recv header:
        	15:00:25.618419 http.c:699              == Info: transfer closed with outstanding read data remaining
        	15:00:25.618545 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 18 transfer closed with outstanding read data remaining
        	error: 1092 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:163: FAIL: testdata/script/mod_get_direct.txt:12: go list -m cloud.google.com/go@main: exit status 1
--- FAIL: TestScript/mod_get_direct (446.13s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-10-21 18:32 gotip-linux-amd64-longtest go@67f662b2 cmd/go.TestScript/mod_gonoproxy (log) 
=== RUN   TestScript/mod_gonoproxy
=== PAUSE TestScript/mod_gonoproxy
=== CONT  TestScript/mod_gonoproxy
    script_test.go:139: 2024-10-21T18:42:58Z
    script_test.go:141: $WORK=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-4100123143/tmpdir4083788283/mod_gonoproxy1343629696
    script_test.go:163: 
        PATH=/home/swarming/.swarming/w/ir/x/t/cmd-go-test-4100123143/tmpdir4083788283/testbin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/x/w/goroot/bin:/home/swarming/.swarming/w/ir/cache/tools/bin:/home/swarming/.swarming/w/ir/bbagent_utility_packages:/home/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages:/home/swarming/.swarming/w/ir/cipd_bin_packages/bin:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/home/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/home/swarming/.swarming/w/ir/cache/cipd_client:/home/swarming/.swarming/w/ir/cache/cipd_client/bin:/home/swarming/.swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	18:43:22.338543 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):
        	18:43:22.338573 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):
        	18:43:22.694864 http.c:699              == Info: TLSv1.3 (IN), TLS Unknown, Unknown (23):
        	18:43:22.694892 http.c:699              == Info: Connection #0 to host go.googlesource.com left intact
        	error: 20976 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:163: FAIL: testdata/script/mod_gonoproxy.txt:51: go list -m all: exit status 1
--- FAIL: TestScript/mod_gonoproxy (24.38s)

— watchflakes

@gopherbot
Copy link
Contributor

Found new dashboard test flakes for:

#!watchflakes
post <- `unexpected disconnect while reading sideband packet`
2024-10-30 17:05 go1.23-darwin-amd64-longtest release-branch.go1.23@a0d15cb9 cmd/go.TestScript/mod_invalid_version (log) 
=== RUN   TestScript/mod_invalid_version
=== PAUSE TestScript/mod_invalid_version
=== CONT  TestScript/mod_invalid_version
    script_test.go:135: 2024-10-31T00:53:31Z
    script_test.go:137: $WORK=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-1810338610/tmpdir1437776016/mod_invalid_version906130486
    script_test.go:159: 
        PATH=/Users/swarming/.swarming/w/ir/x/t/cmd-go-test-1810338610/tmpdir1437776016/testbin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/x/w/goroot/bin:/Users/swarming/.swarming/w/ir/cache/tools/bin:/Users/swarming/.swarming/w/ir/bbagent_utility_packages:/Users/swarming/.swarming/w/ir/bbagent_utility_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages:/Users/swarming/.swarming/w/ir/cipd_bin_packages/bin:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3:/Users/swarming/.swarming/w/ir/cipd_bin_packages/cpython3/bin:/Users/swarming/.swarming/w/ir/cache/cipd_client:/Users/swarming/.swarming/w/ir/cache/cipd_client/bin:/Users/swarming/.swarming/cipd_cache/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin
        HOME=/no-home
        CCACHE_DISABLE=1
        GOARCH=amd64
...
        	17:53:33.412826 http.c:658              <= Recv header:
        	18:02:38.950891 http.c:699              == Info: SSLRead() return error -36
        	18:02:38.950949 http.c:699              == Info: Closing connection 0
        	error: RPC failed; curl 56 SSLRead() return error -36
        	error: 20582 bytes of body are still expected
        	fetch-pack: unexpected disconnect while reading sideband packet
        	fatal: early EOF
        	fatal: fetch-pack: invalid index-pack output
    script_test.go:159: FAIL: testdata/script/mod_invalid_version.txt:24: go list -m golang.org/x/text: exit status 1
--- FAIL: TestScript/mod_invalid_version (547.10s)

— watchflakes

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one.
Projects
Test Flakes
Status: Active
Milestone
Unreleased
Development

No branches or pull requests
3 participants
@bcmills @gopherbot @joedian