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.

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

net: TestSplice failures #58787

Open
gopherbot opened this issue Feb 28, 2023 · 4 comments
Open

net: TestSplice failures #58787

gopherbot opened this issue Feb 28, 2023 · 4 comments
Assignees
@panjf2000
Labels
NeedsFix The path to resolution is known, but the work has not been done.
Milestone
Go1.21

Comments

@gopherbot
Copy link 

#!watchflakes
post <- pkg == "net" && test == "TestSplice"

Issue created automatically to collect these failures.

Example (log):

panic: test timed out after 12m0s
running tests:
	TestSplice (11m41s)
	TestSplice/tcp-to-file (11m3s)
	TestSplice/tcp-to-file/big (11m3s)

runtime.gopark(0x1c800?, 0x3fc844a630?, 0x18?, 0x0?, 0x18?)
	/home/gopher/build/go/src/runtime/proc.go:381 +0x10c fp=0x3fc8576df0 sp=0x3fc8576dd8 pc=0x4a6dc
runtime.chanrecv(0x3fc83d2540, 0x3fc8576ed7, 0xc?)
	/home/gopher/build/go/src/runtime/chan.go:583 +0x430 fp=0x3fc8576e68 sp=0x3fc8576df0 pc=0x16368
runtime.chanrecv1(0x4511c0?, 0x22a6e0?)
	/home/gopher/build/go/src/runtime/chan.go:442 +0x14 fp=0x3fc8576e88 sp=0x3fc8576e68 pc=0x15ef4
testing.(*T).Run(0x3fc845d1e0, {0x276f68?, 0x3f1b99fe87?}, 0x28cf60)
	/home/gopher/build/go/src/testing/testing.go:1633 +0x380 fp=0x3fc8576f40 sp=0x3fc8576e88 pc=0xed020
net.TestSplice(0x3fc845d1e0)
	/home/gopher/build/go/src/net/splice_test.go:26 +0xc8 fp=0x3fc8576f78 sp=0x3fc8576f40 pc=0x1d2388
testing.tRunner(0x3fc845d1e0, 0x28cf70)

— 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 28, 2023
@gopherbot
Copy link
Author

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "net" && test == "TestSplice"
2023-02-27 15:31 linux-riscv64-jsing go@fcfbbf2f net.TestSplice (log) 
panic: test timed out after 12m0s
running tests:
	TestSplice (11m41s)
	TestSplice/tcp-to-file (11m3s)
	TestSplice/tcp-to-file/big (11m3s)

runtime.gopark(0x1c800?, 0x3fc844a630?, 0x18?, 0x0?, 0x18?)
	/home/gopher/build/go/src/runtime/proc.go:381 +0x10c fp=0x3fc8576df0 sp=0x3fc8576dd8 pc=0x4a6dc
runtime.chanrecv(0x3fc83d2540, 0x3fc8576ed7, 0xc?)
	/home/gopher/build/go/src/runtime/chan.go:583 +0x430 fp=0x3fc8576e68 sp=0x3fc8576df0 pc=0x16368
runtime.chanrecv1(0x4511c0?, 0x22a6e0?)
	/home/gopher/build/go/src/runtime/chan.go:442 +0x14 fp=0x3fc8576e88 sp=0x3fc8576e68 pc=0x15ef4
testing.(*T).Run(0x3fc845d1e0, {0x276f68?, 0x3f1b99fe87?}, 0x28cf60)
	/home/gopher/build/go/src/testing/testing.go:1633 +0x380 fp=0x3fc8576f40 sp=0x3fc8576e88 pc=0xed020
net.TestSplice(0x3fc845d1e0)
	/home/gopher/build/go/src/net/splice_test.go:26 +0xc8 fp=0x3fc8576f78 sp=0x3fc8576f40 pc=0x1d2388
testing.tRunner(0x3fc845d1e0, 0x28cf70)
2023-02-28 01:11 linux-riscv64-jsing go@dd16258f net.TestSplice (log) 
panic: test timed out after 12m0s
running tests:
	TestSplice (11m56s)
	TestSplice/unix-to-file (10m19s)
	TestSplice/unix-to-file/big (10m19s)

runtime.gopark(0x1c7f8?, 0x3f984b4840?, 0x18?, 0x0?, 0x18?)
	/home/gopher/build/go/src/runtime/proc.go:381 +0x10c fp=0x3f980bd5f0 sp=0x3f980bd5d8 pc=0x4a644
runtime.chanrecv(0x3f98332700, 0x3f980bd6d7, 0x9c?)
	/home/gopher/build/go/src/runtime/chan.go:583 +0x430 fp=0x3f980bd668 sp=0x3f980bd5f0 pc=0x16368
runtime.chanrecv1(0x4501c0?, 0x22a2e0?)
	/home/gopher/build/go/src/runtime/chan.go:442 +0x14 fp=0x3f980bd688 sp=0x3f980bd668 pc=0x15ef4
testing.(*T).Run(0x3f984791e0, {0x27722e?, 0x3f091757ed?}, 0x28cb90)
	/home/gopher/build/go/src/testing/testing.go:1633 +0x380 fp=0x3f980bd740 sp=0x3f980bd688 pc=0xecdb0
net.TestSplice(0x3f984791e0)
	/home/gopher/build/go/src/net/splice_test.go:27 +0xe4 fp=0x3f980bd778 sp=0x3f980bd740 pc=0x1d1fa4
testing.tRunner(0x3f984791e0, 0x28cb98)

— watchflakes

@panjf2000 panjf2000 self-assigned this Feb 28, 2023
@panjf2000 panjf2000 added this to the Backlog milestone Feb 28, 2023
@gopherbot
Copy link
Author

Change https://go.dev/cl/471995 mentions this issue: net: use /dev/null for TestSplice of big file to fix the test flakes on linux-riscv64-jsing

@dmitshur dmitshur added NeedsFix The path to resolution is known, but the work has not been done. and removed NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one. labels Feb 28, 2023
@dmitshur dmitshur modified the milestones: Backlog, Go1.21 Feb 28, 2023
@gopherbot
Copy link
Author

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "net" && test == "TestSplice"
2023-02-27 11:58 linux-riscv64-jsing go@ac27b4dd net.TestSplice (log) 
panic: test timed out after 12m0s
running tests:
	TestSplice (11m53s)
	TestSplice/tcp-to-file (11m28s)
	TestSplice/tcp-to-file/big (11m28s)

runtime.gopark(0x1c800?, 0x3fcc00c5a0?, 0x18?, 0x0?, 0x18?)
	/home/gopher/build/go/src/runtime/proc.go:381 +0x10c fp=0x3fcc509df0 sp=0x3fcc509dd8 pc=0x4a6dc
runtime.chanrecv(0x3fcc2e42a0, 0x3fcc509ed7, 0xfc?)
	/home/gopher/build/go/src/runtime/chan.go:583 +0x430 fp=0x3fcc509e68 sp=0x3fcc509df0 pc=0x16368
runtime.chanrecv1(0x4511c0?, 0x22a6e0?)
	/home/gopher/build/go/src/runtime/chan.go:442 +0x14 fp=0x3fcc509e88 sp=0x3fcc509e68 pc=0x15ef4
testing.(*T).Run(0x3fcc3a49c0, {0x276f68?, 0x3f0871291e?}, 0x28cf60)
	/home/gopher/build/go/src/testing/testing.go:1633 +0x380 fp=0x3fcc509f40 sp=0x3fcc509e88 pc=0xed010
net.TestSplice(0x3fcc3a49c0)
	/home/gopher/build/go/src/net/splice_test.go:26 +0xc8 fp=0x3fcc509f78 sp=0x3fcc509f40 pc=0x1d2378
testing.tRunner(0x3fcc3a49c0, 0x28cf70)
2023-02-27 12:43 linux-riscv64-jsing go@85b55c79 net.TestSplice (log) 
panic: test timed out after 12m0s
running tests:
	TestSplice (11m57s)
	TestSplice/tcp-to-file (11m30s)
	TestSplice/tcp-to-file/big (11m30s)

runtime.gopark(0x1c800?, 0x3fb800c750?, 0x18?, 0x0?, 0x18?)
	/home/gopher/build/go/src/runtime/proc.go:381 +0x10c fp=0x3fb8035dc8 sp=0x3fb8035db0 pc=0x4a6dc
runtime.chanrecv(0x3fb805e460, 0x3fb8035eaf, 0xc?)
	/home/gopher/build/go/src/runtime/chan.go:583 +0x430 fp=0x3fb8035e40 sp=0x3fb8035dc8 pc=0x16368
runtime.chanrecv1(0x4511c0?, 0x22a6e0?)
	/home/gopher/build/go/src/runtime/chan.go:442 +0x14 fp=0x3fb8035e60 sp=0x3fb8035e40 pc=0x15ef4
testing.(*T).Run(0x3fb82a7d40, {0x27454c?, 0x0?}, 0x3fb8060d40)
	/home/gopher/build/go/src/testing/testing.go:1633 +0x380 fp=0x3fb8035f18 sp=0x3fb8035e60 pc=0xed020
net.testSpliceToFile(0x3125731c48a2b2?, {0x2745c1, 0x3}, {0x27478f, 0x4})
	/home/gopher/build/go/src/net/splice_test.go:35 +0x228 fp=0x3fb8035f48 sp=0x3fb8035f18 pc=0x1d2610
net.TestSplice.func3(0x3fb84331e0?)
	/home/gopher/build/go/src/net/splice_test.go:26 +0x40 fp=0x3fb8035f78 sp=0x3fb8035f48 pc=0x1f3e20
testing.tRunner(0x3fb82a7d40, 0x28cf60)
2023-02-27 21:45 linux-riscv64-jsing go@676794f7 net.TestSplice (log) 
panic: test timed out after 12m0s
running tests:
	TestSplice (11m54s)
	TestSplice/tcp-to-file (11m28s)
	TestSplice/tcp-to-file/big (11m28s)

runtime.gopark(0x1c7f8?, 0x3fb054a180?, 0x18?, 0x0?, 0x18?)
	/home/gopher/build/go/src/runtime/proc.go:381 +0x10c fp=0x3fb0511df0 sp=0x3fb0511dd8 pc=0x4a644
runtime.chanrecv(0x3fb0206070, 0x3fb0511ed7, 0x8c?)
	/home/gopher/build/go/src/runtime/chan.go:583 +0x430 fp=0x3fb0511e68 sp=0x3fb0511df0 pc=0x16368
runtime.chanrecv1(0x4501c0?, 0x22a2e0?)
	/home/gopher/build/go/src/runtime/chan.go:442 +0x14 fp=0x3fb0511e88 sp=0x3fb0511e68 pc=0x15ef4
testing.(*T).Run(0x3fb0393380, {0x276b68?, 0x3f35efb584?}, 0x28cb88)
	/home/gopher/build/go/src/testing/testing.go:1633 +0x380 fp=0x3fb0511f40 sp=0x3fb0511e88 pc=0xecda0
net.TestSplice(0x3fb0393380)
	/home/gopher/build/go/src/net/splice_test.go:26 +0xc8 fp=0x3fb0511f78 sp=0x3fb0511f40 pc=0x1d1f78
testing.tRunner(0x3fb0393380, 0x28cb98)
2023-02-27 23:07 linux-riscv64-jsing go@fa9efd91 net.TestSplice (log) 
panic: test timed out after 12m0s
running tests:
	TestSplice (11m54s)
	TestSplice/unix-to-file (10m9s)
	TestSplice/unix-to-file/big (10m8s)

runtime.gopark(0x1c7f8?, 0x3fb80a48e8?, 0x18?, 0x0?, 0x18?)
	/home/gopher/build/go/src/runtime/proc.go:381 +0x10c fp=0x3fb80375f0 sp=0x3fb80375d8 pc=0x4a644
runtime.chanrecv(0x3fb84fe7e0, 0x3fb80376d7, 0x9c?)
	/home/gopher/build/go/src/runtime/chan.go:583 +0x430 fp=0x3fb8037668 sp=0x3fb80375f0 pc=0x16368
runtime.chanrecv1(0x4501c0?, 0x22a2e0?)
	/home/gopher/build/go/src/runtime/chan.go:442 +0x14 fp=0x3fb8037688 sp=0x3fb8037668 pc=0x15ef4
testing.(*T).Run(0x3fb8484340, {0x27722e?, 0x3f25690331?}, 0x28cb90)
	/home/gopher/build/go/src/testing/testing.go:1633 +0x380 fp=0x3fb8037740 sp=0x3fb8037688 pc=0xecdb0
net.TestSplice(0x3fb8484340)
	/home/gopher/build/go/src/net/splice_test.go:27 +0xe4 fp=0x3fb8037778 sp=0x3fb8037740 pc=0x1d1fa4
testing.tRunner(0x3fb8484340, 0x28cb98)

— watchflakes

@gopherbot gopherbot reopened this Feb 21, 2024
@gopherbot
Copy link
Author

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "net" && test == "TestSplice"
2024-02-21 21:26 android-386-emu go@ccb6077d net.TestSplice (log) 
SIGQUIT: quit
PC=0xe95f6ffd m=0 sigcode=0

goroutine 0 gp=0xe9a10c80 m=0 mp=0xe9a115a0 [idle]:
runtime.futex(0xe9a11668, 0x80, 0x0, 0x0, 0x0, 0x0)
	/workdir/go/src/runtime/sys_linux_386.s:526 +0x1e fp=0xff9df2e0 sp=0xff9df2dc pc=0xe95f6ffe
runtime.futexsleep(0xe9a11668, 0x0, 0xffffffffffffffff)
	/workdir/go/src/runtime/os_linux.go:69 +0x5d fp=0xff9df314 sp=0xff9df2e0 pc=0xe95b445d
runtime.notesleep(0xe9a11668)
	/workdir/go/src/runtime/lock_futex.go:170 +0xbd fp=0xff9df334 sp=0xff9df314 pc=0xe958385d
...
--- FAIL: TestSplice (177.06s)
    --- FAIL: TestSplice/tcp-to-tcp (177.06s)
        --- FAIL: TestSplice/tcp-to-tcp/updatesLimitedReaderN (159.14s)
            splice_linux_test.go:97: readfrom tcp4 127.0.0.1:48149->127.0.0.1:40555: splice: broken pipe
            exec.go:193: test timed out while running command: /data/local/tmp/go_android_exec/net.test-83293/net.test
            mockserver_test.go:578: process exited with error: exit status 2
        --- FAIL: TestSplice/tcp-to-tcp/limitedReaderAtLimit (15.86s)
            splice_linux_test.go:97: readfrom tcp4 127.0.0.1:49467->127.0.0.1:50912: splice: broken pipe
            exec.go:193: test timed out while running command: /data/local/tmp/go_android_exec/net.test-83293/net.test
            mockserver_test.go:578: process exited with error: exit status 2
...
panic: test timed out after 3m0s
running tests:
	TestPipe (0s)
	TestPipe/PingPong (0s)

goroutine 1304 [running]:
testing.(*M).startAlarm.func1()
	/workdir/go/src/testing/testing.go:2366 +0x3e1
created by time.goFunc
	/workdir/go/src/time/sleep.go:177 +0x35

— watchflakes

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@panjf2000 panjf2000

Labels
NeedsFix The path to resolution is known, but the work has not been done.
Projects
Test Flakes
Status: Done
Milestone
Go1.21
Development

No branches or pull requests
3 participants
@dmitshur @panjf2000 @gopherbot