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

x/pkgsite/cmd/internal/pkgsite: TestServer failures #65876

Closed
gopherbot opened this issue Feb 22, 2024 · 7 comments
Closed

x/pkgsite/cmd/internal/pkgsite: TestServer failures #65876

gopherbot opened this issue Feb 22, 2024 · 7 comments
Labels
NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one.
Milestone
Unreleased

Comments

@gopherbot
Copy link
Contributor

gopherbot commented Feb 22, 2024 •
edited by bcmills 

#!watchflakes
post <- (goos == "android" || goos == "linux") && pkg == "golang.org/x/pkgsite/cmd/internal/pkgsite" && test == "TestServer" && date < "2024-02-24"

Issue created automatically to collect these failures.

Example (log):

2024/02/22 05:40:36 Info: go/packages.Load(["all"]) loaded 1 packages from /data/local/tmp/go_android_exec/pkgsite.test-11213/TestServer1827960669/001 in 89.90504ms
2024/02/22 05:40:36 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 05:40:36 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 332.85µs with error <nil>
2024/02/22 05:40:36 Info: FetchDataSource: fetching std@latest
2024/02/22 05:40:36 Info: FetchDataSource: fetched std@latest using *fetch.modCacheModuleGetter in 62.08µs with error modCacheGetter.Info("std", "latest"): modCacheModuleGetter.latestVersion("std"): path: malformed module path "std": missing dot in first path element: invalid argument
2024/02/22 05:40:36 Info: FetchDataSource: fetching example.com/testmod@latest
2024/02/22 05:40:36 Info: FetchDataSource: fetched example.com/testmod@latest using *fetch.goPackagesModuleGetter in 1.14266ms with error <nil>
2024/02/22 05:40:36 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 05:40:36 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 1.13871ms with error <nil>
2024/02/22 05:40:36 Error: Server.GetLatestInfo: FetchDataSource.GetLatestInfo(ctx, "example.com/testmod", "example.com/testmod"): proxy.Client.Info("example.com/testmod", "latest"): Client.readBody("example.com/testmod", "latest", "info"): executeRequest(ctx, "https://127.0.0.1:37262/example.com/testmod/@latest"): "404 page not found\n": not found
2024/02/22 05:40:37 Info: go/packages.Load(["all"]) loaded 1 packages from /data/local/tmp/go_android_exec/pkgsite.test-11213/TestServer1827960669/001 in 62.89562ms
2024/02/22 05:40:37 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 05:40:37 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 314.41µs with error <nil>
2024/02/22 05:40:37 Info: FetchDataSource: fetching std@latest
2024/02/22 05:40:37 Info: FetchDataSource: fetched std@latest using *fetch.modCacheModuleGetter in 63.97µs with error modCacheGetter.Info("std", "latest"): modCacheModuleGetter.latestVersion("std"): path: malformed module path "std": missing dot in first path element: invalid argument
2024/02/22 05:40:37 Info: FetchDataSource: fetching modcache.com@v1.0.0
2024/02/22 05:40:37 Info: FetchDataSource: fetched modcache.com@v1.0.0 using *fetch.modCacheModuleGetter in 5.78229ms with error <nil>
panic: test timed out after 10m0s
running tests:
	TestServer (10m0s)
	TestServer/modcache (10m0s)

testing.(*T).Run(0xcb5f0108, {0xec574d56, 0x8}, 0xcb4171e0)
	/workdir/go/src/testing/testing.go:1750 +0x436
golang.org/x/pkgsite/cmd/internal/pkgsite.TestServer(0xcb5f0108)
	/workdir/gopath/src/golang.org/x/pkgsite/cmd/internal/pkgsite/server_test.go:197 +0xeed
testing.tRunner(0xcb5f0108, 0xeccd51c8)

— watchflakes
@gopherbot gopherbot added the NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one. label Feb 22, 2024
@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "golang.org/x/pkgsite/cmd/internal/pkgsite" && test == "TestServer"
2024-02-21 20:50 android-386-emu pkgsite@463d7c94 go@7fd62ba8 x/pkgsite/cmd/internal/pkgsite.TestServer (log) 
2024/02/22 05:40:36 Info: go/packages.Load(["all"]) loaded 1 packages from /data/local/tmp/go_android_exec/pkgsite.test-11213/TestServer1827960669/001 in 89.90504ms
2024/02/22 05:40:36 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 05:40:36 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 332.85µs with error <nil>
2024/02/22 05:40:36 Info: FetchDataSource: fetching std@latest
2024/02/22 05:40:36 Info: FetchDataSource: fetched std@latest using *fetch.modCacheModuleGetter in 62.08µs with error modCacheGetter.Info("std", "latest"): modCacheModuleGetter.latestVersion("std"): path: malformed module path "std": missing dot in first path element: invalid argument
2024/02/22 05:40:36 Info: FetchDataSource: fetching example.com/testmod@latest
2024/02/22 05:40:36 Info: FetchDataSource: fetched example.com/testmod@latest using *fetch.goPackagesModuleGetter in 1.14266ms with error <nil>
2024/02/22 05:40:36 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 05:40:36 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 1.13871ms with error <nil>
2024/02/22 05:40:36 Error: Server.GetLatestInfo: FetchDataSource.GetLatestInfo(ctx, "example.com/testmod", "example.com/testmod"): proxy.Client.Info("example.com/testmod", "latest"): Client.readBody("example.com/testmod", "latest", "info"): executeRequest(ctx, "https://127.0.0.1:37262/example.com/testmod/@latest"): "404 page not found\n": not found
2024/02/22 05:40:37 Info: go/packages.Load(["all"]) loaded 1 packages from /data/local/tmp/go_android_exec/pkgsite.test-11213/TestServer1827960669/001 in 62.89562ms
2024/02/22 05:40:37 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 05:40:37 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 314.41µs with error <nil>
2024/02/22 05:40:37 Info: FetchDataSource: fetching std@latest
2024/02/22 05:40:37 Info: FetchDataSource: fetched std@latest using *fetch.modCacheModuleGetter in 63.97µs with error modCacheGetter.Info("std", "latest"): modCacheModuleGetter.latestVersion("std"): path: malformed module path "std": missing dot in first path element: invalid argument
2024/02/22 05:40:37 Info: FetchDataSource: fetching modcache.com@v1.0.0
2024/02/22 05:40:37 Info: FetchDataSource: fetched modcache.com@v1.0.0 using *fetch.modCacheModuleGetter in 5.78229ms with error <nil>
panic: test timed out after 10m0s
running tests:
	TestServer (10m0s)
	TestServer/modcache (10m0s)

testing.(*T).Run(0xcb5f0108, {0xec574d56, 0x8}, 0xcb4171e0)
	/workdir/go/src/testing/testing.go:1750 +0x436
golang.org/x/pkgsite/cmd/internal/pkgsite.TestServer(0xcb5f0108)
	/workdir/gopath/src/golang.org/x/pkgsite/cmd/internal/pkgsite/server_test.go:197 +0xeed
testing.tRunner(0xcb5f0108, 0xeccd51c8)
2024-02-21 20:50 android-amd64-emu pkgsite@463d7c94 go@7fd62ba8 x/pkgsite/cmd/internal/pkgsite.TestServer (log) 
2024/02/22 05:47:02 Info: go/packages.Load(["all"]) loaded 1 packages from /data/local/tmp/go_android_exec/pkgsite.test-11393/TestServer1734583538/001 in 182.70968ms
2024/02/22 05:47:02 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 05:47:02 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 556.75µs with error <nil>
2024/02/22 05:47:02 Info: FetchDataSource: fetching std@latest
2024/02/22 05:47:02 Info: FetchDataSource: fetched std@latest using *fetch.modCacheModuleGetter in 57.74µs with error modCacheGetter.Info("std", "latest"): modCacheModuleGetter.latestVersion("std"): path: malformed module path "std": missing dot in first path element: invalid argument
2024/02/22 05:47:02 Info: FetchDataSource: fetching example.com/testmod@latest
2024/02/22 05:47:02 Info: FetchDataSource: fetched example.com/testmod@latest using *fetch.goPackagesModuleGetter in 470.63µs with error <nil>
2024/02/22 05:47:02 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 05:47:02 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 435.24µs with error <nil>
2024/02/22 05:47:02 Error: Server.GetLatestInfo: FetchDataSource.GetLatestInfo(ctx, "example.com/testmod", "example.com/testmod"): proxy.Client.Info("example.com/testmod", "latest"): Client.readBody("example.com/testmod", "latest", "info"): executeRequest(ctx, "https://127.0.0.1:55571/example.com/testmod/@latest"): "404 page not found\n": not found
...
2024/02/22 05:47:05 Info: returning 424 (Failed Dependency) for error 424 (Failed Dependency): <nil> (epage=&{{   <nil> false false   false false    }  <h3 class="Error-message">This page is not supported by this datasource.</h3> <nil>})
2024/02/22 05:47:05 Info: go/packages.Load(["all"]) loaded 1 packages from /data/local/tmp/go_android_exec/pkgsite.test-11393/TestServer1734583538/001 in 52.15007ms
2024/02/22 05:47:05 Info: FetchDataSource: fetching std@latest
2024/02/22 05:47:05 Info: FetchDataSource: fetched std@latest using *fetch.modCacheModuleGetter in 54.26µs with error modCacheGetter.Info("std", "latest"): modCacheModuleGetter.latestVersion("std"): path: malformed module path "std": missing dot in first path element: invalid argument
2024/02/22 05:47:05 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 05:47:05 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 524.76µs with error <nil>
2024/02/22 05:47:05 Info: returning 424 (Failed Dependency) for error 424 (Failed Dependency): <nil> (epage=&{{   <nil> false false   false false    }  <h3 class="Error-message">This page is not supported by this datasource.</h3> <nil>})
--- FAIL: TestServer (3.36s)
    --- FAIL: TestServer/search_not_found (0.01s)
        server_test.go:200: failed to load any module(s) at map[/data/local/tmp/go_android_exec/pkgsite.test-11393/TestServer1734583538/001:[{example.com/testmod /data/local/tmp/go_android_exec/pkgsite.test-11393/TestServer1734583538/001}]]

— watchflakes

@gopherbot gopherbot added this to the Unreleased milestone Feb 22, 2024
@hyangah
Copy link
Contributor

hyangah commented Feb 22, 2024

cc @jba @matloob

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "golang.org/x/pkgsite/cmd/internal/pkgsite" && test == "TestServer"
2024-02-21 20:50 android-386-emu pkgsite@463d7c94 go@f278f756 x/pkgsite/cmd/internal/pkgsite.TestServer (log) 
2024/02/22 16:57:09 Info: go/packages.Load(["all"]) loaded 1 packages from /data/local/tmp/go_android_exec/pkgsite.test-11429/TestServer1125506187/001 in 87.47091ms
2024/02/22 16:57:09 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 16:57:09 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 414.46µs with error <nil>
2024/02/22 16:57:09 Info: FetchDataSource: fetching std@latest
2024/02/22 16:57:09 Info: FetchDataSource: fetched std@latest using *fetch.modCacheModuleGetter in 66.23µs with error modCacheGetter.Info("std", "latest"): modCacheModuleGetter.latestVersion("std"): path: malformed module path "std": missing dot in first path element: invalid argument
2024/02/22 16:57:09 Info: FetchDataSource: fetching example.com/testmod@latest
2024/02/22 16:57:09 Info: FetchDataSource: fetched example.com/testmod@latest using *fetch.goPackagesModuleGetter in 477.18µs with error <nil>
2024/02/22 16:57:09 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 16:57:09 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 362.07µs with error <nil>
2024/02/22 16:57:09 Error: Server.GetLatestInfo: FetchDataSource.GetLatestInfo(ctx, "example.com/testmod", "example.com/testmod"): proxy.Client.Info("example.com/testmod", "latest"): Client.readBody("example.com/testmod", "latest", "info"): executeRequest(ctx, "https://127.0.0.1:40575/example.com/testmod/@latest"): "404 page not found\n": not found
...
panic: test timed out after 10m0s
running tests:
	TestServer (10m0s)
	TestServer/search_vulns_not_found (9m56s)

testing.(*T).Run(0xc827c108, {0xe9280bdf, 0x16}, 0xcb421d80)
	/workdir/go/src/testing/testing.go:1750 +0x436
golang.org/x/pkgsite/cmd/internal/pkgsite.TestServer(0xc827c108)
	/workdir/gopath/src/golang.org/x/pkgsite/cmd/internal/pkgsite/server_test.go:197 +0xeed
testing.tRunner(0xc827c108, 0xe99c9168)

— watchflakes

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "golang.org/x/pkgsite/cmd/internal/pkgsite" && test == "TestServer"
2024-02-21 20:50 android-386-emu pkgsite@463d7c94 go@d892cb49 x/pkgsite/cmd/internal/pkgsite.TestServer (log) 
2024/02/22 22:35:08 Info: go/packages.Load(["all"]) loaded 1 packages from /data/local/tmp/go_android_exec/pkgsite.test-10999/TestServer1886455896/001 in 102.58581ms
2024/02/22 22:35:08 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 22:35:08 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 302.85µs with error <nil>
2024/02/22 22:35:08 Info: FetchDataSource: fetching std@latest
2024/02/22 22:35:08 Info: FetchDataSource: fetched std@latest using *fetch.modCacheModuleGetter in 60µs with error modCacheGetter.Info("std", "latest"): modCacheModuleGetter.latestVersion("std"): path: malformed module path "std": missing dot in first path element: invalid argument
2024/02/22 22:35:08 Info: FetchDataSource: fetching example.com/testmod@latest
2024/02/22 22:35:08 Info: FetchDataSource: fetched example.com/testmod@latest using *fetch.goPackagesModuleGetter in 1.10924ms with error <nil>
2024/02/22 22:35:08 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/22 22:35:08 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 382.45µs with error <nil>
2024/02/22 22:35:08 Error: Server.GetLatestInfo: FetchDataSource.GetLatestInfo(ctx, "example.com/testmod", "example.com/testmod"): proxy.Client.Info("example.com/testmod", "latest"): Client.readBody("example.com/testmod", "latest", "info"): executeRequest(ctx, "https://127.0.0.1:37320/example.com/testmod/@latest"): "404 page not found\n": not found
...
panic: test timed out after 10m0s
running tests:
	TestServer (10m0s)
	TestServer/search_not_found (9m57s)

testing.(*T).Run(0xc8e8c108, {0xe9dfb9fb, 0x10}, 0xcdd01e50)
	/workdir/go/src/testing/testing.go:1750 +0x436
golang.org/x/pkgsite/cmd/internal/pkgsite.TestServer(0xc8e8c108)
	/workdir/gopath/src/golang.org/x/pkgsite/cmd/internal/pkgsite/server_test.go:197 +0xeed
testing.tRunner(0xc8e8c108, 0xea54c2a8)

— watchflakes

@bcmills
Copy link
Contributor

bcmills commented Feb 23, 2024

Duplicate of #65857

@bcmills bcmills marked this as a duplicate of #65857 Feb 23, 2024
@bcmills bcmills closed this as not planned Won't fix, can't repro, duplicate, stale Feb 23, 2024
@gopherbot

This comment was marked as resolved.

Sign in to view
@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
post <- (goos == "android" || goos == "linux") && pkg == "golang.org/x/pkgsite/cmd/internal/pkgsite" && test == "TestServer" && date < "2024-02-24"
2024-02-22 22:32 android-amd64-emu pkgsite@094b90f1 go@ad377e90 x/pkgsite/cmd/internal/pkgsite.TestServer (log) 
2024/02/23 08:46:38 Info: go/packages.Load(["all"]) loaded 1 packages from /data/local/tmp/go_android_exec/pkgsite.test-11846/TestServer3924697756/001 in 127.65439ms
2024/02/23 08:46:38 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/23 08:46:38 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 1.26911ms with error <nil>
2024/02/23 08:46:38 Info: FetchDataSource: fetching std@latest
2024/02/23 08:46:38 Info: FetchDataSource: fetched std@latest using *fetch.modCacheModuleGetter in 140.84µs with error modCacheGetter.Info("std", "latest"): modCacheModuleGetter.latestVersion("std"): path: malformed module path "std": missing dot in first path element: invalid argument
2024/02/23 08:46:38 Info: FetchDataSource: fetching example.com/testmod@latest
2024/02/23 08:46:38 Info: FetchDataSource: fetched example.com/testmod@latest using *fetch.goPackagesModuleGetter in 665.75µs with error <nil>
2024/02/23 08:46:38 Info: FetchDataSource: fetching example.com/testmod@v0.0.0
2024/02/23 08:46:38 Info: FetchDataSource: fetched example.com/testmod@v0.0.0 using *fetch.goPackagesModuleGetter in 413.23µs with error <nil>
2024/02/23 08:46:38 Error: Server.GetLatestInfo: FetchDataSource.GetLatestInfo(ctx, "example.com/testmod", "example.com/testmod"): proxy.Client.Info("example.com/testmod", "latest"): Client.readBody("example.com/testmod", "latest", "info"): executeRequest(ctx, "https://127.0.0.1:35410/example.com/testmod/@latest"): "404 page not found\n": not found
...
panic: test timed out after 10m0s
running tests:
	TestServer (10m0s)
	TestServer/no_symbol_search (9m56s)

testing.(*T).Run(0xc0000dbba0, {0x76fe1584751b?, 0x1?}, 0xc004ce0020)
	/workdir/go/src/testing/testing.go:1750 +0x3ab
golang.org/x/pkgsite/cmd/internal/pkgsite.TestServer(0xc0000dbba0)
	/workdir/gopath/src/golang.org/x/pkgsite/cmd/internal/pkgsite/server_test.go:197 +0xe25
testing.tRunner(0xc0000dbba0, 0x76fe15fe8ae0)

— 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
Archived in project
Milestone
Unreleased
Development

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