Skip to content

internal/godebug: TestCmdBisect failures #60085

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
Open
gopherbot opened this issue May 9, 2023 · 9 comments
Open

internal/godebug: TestCmdBisect failures #60085

gopherbot opened this issue May 9, 2023 · 9 comments
Labels
compiler/runtime Issues related to the Go compiler and/or runtime. NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one.

Comments

@gopherbot
Copy link
Contributor 

#!watchflakes
post <- pkg == "internal/godebug" && test == "TestCmdBisect"

Issue created automatically to collect these failures.

Example (log):

--- FAIL: TestCmdBisect (0.77s)
    godebug_test.go:98: bad bisect output:
        have [godebug_test.go:115]
        want [godebug_test.go:115 godebug_test.go:118 godebug_test.go:119]
        complete output:
        bisect: checking target with all changes disabled
        bisect: run: GODEBUG=buggy=1#n /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build4047929630/b001/godebug.test -test.run=BisectTestCase... ok (4 matches)
        bisect: run: GODEBUG=buggy=1#n /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build4047929630/b001/godebug.test -test.run=BisectTestCase... ok (4 matches)
        bisect: checking target with all changes enabled
        bisect: run: GODEBUG=buggy=1#y /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build4047929630/b001/godebug.test -test.run=BisectTestCase... FAIL (5 matches)
...
        testing.tRunner()
        	/ramdisk8GB/workdir-host-aix-ppc64-osuosl/go/src/testing/testing.go:1595
        runtime.goexit()
        	/ramdisk8GB/workdir-host-aix-ppc64-osuosl/go/src/runtime/asm_ppc64x.s:885

        ---
        bisect: checking for more failures
        bisect: run: GODEBUG=buggy=1#-110 /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build4047929630/b001/godebug.test -test.run=BisectTestCase... ok (3 matches)
        bisect: run: GODEBUG=buggy=1#-110 /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build4047929630/b001/godebug.test -test.run=BisectTestCase... ok (3 matches)
        bisect: target succeeds with all remaining changes enabled

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

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/godebug" && test == "TestCmdBisect"
2023-05-09 17:55 aix-ppc64 go@734b26d4 internal/godebug.TestCmdBisect (log) 
--- FAIL: TestCmdBisect (0.77s)
    godebug_test.go:98: bad bisect output:
        have [godebug_test.go:115]
        want [godebug_test.go:115 godebug_test.go:118 godebug_test.go:119]
        complete output:
        bisect: checking target with all changes disabled
        bisect: run: GODEBUG=buggy=1#n /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build4047929630/b001/godebug.test -test.run=BisectTestCase... ok (4 matches)
        bisect: run: GODEBUG=buggy=1#n /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build4047929630/b001/godebug.test -test.run=BisectTestCase... ok (4 matches)
        bisect: checking target with all changes enabled
        bisect: run: GODEBUG=buggy=1#y /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build4047929630/b001/godebug.test -test.run=BisectTestCase... FAIL (5 matches)
...
        testing.tRunner()
        	/ramdisk8GB/workdir-host-aix-ppc64-osuosl/go/src/testing/testing.go:1595
        runtime.goexit()
        	/ramdisk8GB/workdir-host-aix-ppc64-osuosl/go/src/runtime/asm_ppc64x.s:885

        ---
        bisect: checking for more failures
        bisect: run: GODEBUG=buggy=1#-110 /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build4047929630/b001/godebug.test -test.run=BisectTestCase... ok (3 matches)
        bisect: run: GODEBUG=buggy=1#-110 /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build4047929630/b001/godebug.test -test.run=BisectTestCase... ok (3 matches)
        bisect: target succeeds with all remaining changes enabled

— watchflakes

@gopherbot gopherbot added the compiler/runtime Issues related to the Go compiler and/or runtime. label May 9, 2023
@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/godebug" && test == "TestCmdBisect"
2023-05-09 18:03 aix-ppc64 go@fffddce5 internal/godebug.TestCmdBisect (log) 
--- FAIL: TestCmdBisect (0.79s)
    godebug_test.go:98: bad bisect output:
        have [godebug_test.go:115]
        want [godebug_test.go:115 godebug_test.go:118 godebug_test.go:119]
        complete output:
        bisect: checking target with all changes disabled
        bisect: run: GODEBUG=buggy=1#n /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build476210264/b001/godebug.test -test.run=BisectTestCase... ok (4 matches)
        bisect: run: GODEBUG=buggy=1#n /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build476210264/b001/godebug.test -test.run=BisectTestCase... ok (4 matches)
        bisect: checking target with all changes enabled
        bisect: run: GODEBUG=buggy=1#y /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build476210264/b001/godebug.test -test.run=BisectTestCase... FAIL (5 matches)
...
        testing.tRunner()
        	/ramdisk8GB/workdir-host-aix-ppc64-osuosl/go/src/testing/testing.go:1595
        runtime.goexit()
        	/ramdisk8GB/workdir-host-aix-ppc64-osuosl/go/src/runtime/asm_ppc64x.s:885

        ---
        bisect: checking for more failures
        bisect: run: GODEBUG=buggy=1#-110 /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build476210264/b001/godebug.test -test.run=BisectTestCase... ok (3 matches)
        bisect: run: GODEBUG=buggy=1#-110 /ramdisk8GB/workdir-host-aix-ppc64-osuosl/tmp/go-build476210264/b001/godebug.test -test.run=BisectTestCase... ok (3 matches)
        bisect: target succeeds with all remaining changes enabled

— watchflakes

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/godebug" && test == "TestCmdBisect"
2023-05-09 16:07 freebsd-riscv64-unmatched go@134c9b2b internal/godebug.TestCmdBisect (log) 
--- FAIL: TestCmdBisect (2.67s)
    godebug_test.go:98: bad bisect output:
        have [godebug_test.go:115]
        want [godebug_test.go:115 godebug_test.go:118 godebug_test.go:119]
        complete output:
        bisect: checking target with all changes disabled
        bisect: run: GODEBUG=buggy=1#n /tmp/workdir-host-freebsd-riscv64-unmatched/tmp/go-build1159856441/b001/godebug.test -test.run=BisectTestCase... ok (4 matches)
        bisect: run: GODEBUG=buggy=1#n /tmp/workdir-host-freebsd-riscv64-unmatched/tmp/go-build1159856441/b001/godebug.test -test.run=BisectTestCase... ok (4 matches)
        bisect: checking target with all changes enabled
        bisect: run: GODEBUG=buggy=1#y /tmp/workdir-host-freebsd-riscv64-unmatched/tmp/go-build1159856441/b001/godebug.test -test.run=BisectTestCase... FAIL (5 matches)
...
        testing.tRunner()
        	/tmp/workdir-host-freebsd-riscv64-unmatched/go/src/testing/testing.go:1595
        runtime.goexit()
        	/tmp/workdir-host-freebsd-riscv64-unmatched/go/src/runtime/asm_riscv64.s:512

        ---
        bisect: checking for more failures
        bisect: run: GODEBUG=buggy=1#-001 /tmp/workdir-host-freebsd-riscv64-unmatched/tmp/go-build1159856441/b001/godebug.test -test.run=BisectTestCase... ok (3 matches)
        bisect: run: GODEBUG=buggy=1#-001 /tmp/workdir-host-freebsd-riscv64-unmatched/tmp/go-build1159856441/b001/godebug.test -test.run=BisectTestCase... ok (3 matches)
        bisect: target succeeds with all remaining changes enabled
2023-05-09 16:19 freebsd-riscv64-unmatched go@5751939d internal/godebug.TestCmdBisect (log) 
--- FAIL: TestCmdBisect (2.58s)
    godebug_test.go:98: bad bisect output:
        have [godebug_test.go:115]
        want [godebug_test.go:115 godebug_test.go:118 godebug_test.go:119]
        complete output:
        bisect: checking target with all changes disabled
        bisect: run: GODEBUG=buggy=1#n /tmp/workdir-host-freebsd-riscv64-unmatched/tmp/go-build519471473/b001/godebug.test -test.run=BisectTestCase... ok (4 matches)
        bisect: run: GODEBUG=buggy=1#n /tmp/workdir-host-freebsd-riscv64-unmatched/tmp/go-build519471473/b001/godebug.test -test.run=BisectTestCase... ok (4 matches)
        bisect: checking target with all changes enabled
        bisect: run: GODEBUG=buggy=1#y /tmp/workdir-host-freebsd-riscv64-unmatched/tmp/go-build519471473/b001/godebug.test -test.run=BisectTestCase... FAIL (5 matches)
...
        testing.tRunner()
        	/tmp/workdir-host-freebsd-riscv64-unmatched/go/src/testing/testing.go:1595
        runtime.goexit()
        	/tmp/workdir-host-freebsd-riscv64-unmatched/go/src/runtime/asm_riscv64.s:512

        ---
        bisect: checking for more failures
        bisect: run: GODEBUG=buggy=1#-001 /tmp/workdir-host-freebsd-riscv64-unmatched/tmp/go-build519471473/b001/godebug.test -test.run=BisectTestCase... ok (3 matches)
        bisect: run: GODEBUG=buggy=1#-001 /tmp/workdir-host-freebsd-riscv64-unmatched/tmp/go-build519471473/b001/godebug.test -test.run=BisectTestCase... ok (3 matches)
        bisect: target succeeds with all remaining changes enabled

— watchflakes

@bcmills
Copy link
Contributor

bcmills commented May 17, 2023

@dr2chase, is this believed to be fixed at this point? (The new watchflakes failures are over a week old.)

@dr2chase
Copy link
Contributor

dr2chase commented May 17, 2023 •
edited
Loading

This is supposed to be double-fixed, by https://go.dev/cl/494276 and https://go.dev/cl/494036 both landed on 05-10.

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/godebug" && test == "TestCmdBisect"
2023-05-31 21:23 plan9-arm go@eee6f2b9 internal/godebug.TestCmdBisect (log) 
--- FAIL: TestCmdBisect (1.35s)
    godebug_test.go:77: exec bisect: exit status: 'go 26239: 2'
        runtime: signal received on thread not created by Go.
        runtime: g 116: unexpected return pc for syscall.Syscall6 called from 0x27272030
        stack: frame={sp:0x9935d58, fp:0x9935dec} stack=[0x9916000,0x9936000)
        0x09935cd8:  0x0952e348  0x00072bc8 <runtime.exitsyscall+0x00000134>  0x0952e348  0x00000003 
        0x09935ce8:  0x00000002  0x00000001  0x00000000  0x00000000 
        0x09935cf8:  0x00000000  0x00000000  0x00000000  0x00089668 <syscall.Await+0x00000050> 
        0x09935d08:  0x0000002f  0x09935d4c  0x00000200  0x00000000 
        0x09935d18:  0x00000010  0x00000000  0x00072ae8 <runtime.exitsyscall+0x00000054>  0x09434000 
...
        fatal error: unknown caller pc

        runtime stack:
        runtime.throw({0x67053a, 0x11})
        	runtime/panic.go:1077 +0x4c fp=0x3ffff970 sp=0x3ffff95c pc=0x40d9c
        runtime.(*unwinder).next(0x3ffffaf0)
        	runtime/traceback.go:465 +0x340 fp=0x3ffff9c8 sp=0x3ffff970 pc=0x68a30
        runtime.scanstack(0x952e300, 0x943495c)
        	runtime/mgcmark.go:802 +0x2bc fp=0x3ffffbf0 sp=0x3ffff9c8 pc=0x25c14
        runtime.markroot.func1()
        	runtime/mgcmark.go:240 +0xf4 fp=0x3ffffc1c sp=0x3ffffbf0 pc=0x243a8
        runtime.markroot(0x943495c, 0xc, 0x1)
        	runtime/mgcmark.go:214 +0x234 fp=0x3ffffc78 sp=0x3ffffc1c pc=0x23f84
        runtime.gcDrain(0x943495c, 0x3)
        	runtime/mgcmark.go:1069 +0x5a8 fp=0x3ffffcc4 sp=0x3ffffc78 pc=0x26998
        runtime.gcBgMarkWorker.func2()
        	runtime/mgc.go:1366 +0xb8 fp=0x3ffffcf0 sp=0x3ffffcc4 pc=0x216c0
        runtime.systemstack()
        	runtime/asm_arm.s:317 +0x60 fp=0x3ffffcf4 sp=0x3ffffcf0 pc=0x7506c

— watchflakes

@gopherbot gopherbot reopened this Jun 1, 2023
@github-project-automation github-project-automation bot moved this from Done to In Progress in Go Compiler / Runtime Jun 1, 2023
@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/godebug" && test == "TestCmdBisect"
2024-12-05 18:56 gotip-plan9-386 go@6293a068 internal/godebug.TestCmdBisect (log) 
=== RUN   TestCmdBisect
    godebug_test.go:107: exec bisect: exit status: 'go 4875: 1'
        bisect 4899: suicide: sys: trap: fault write addr=0x4 pc=0x00006070
        exit status: 'bisect 4899: sys: trap: fault write addr=0x4 pc=0x00006070'
--- FAIL: TestCmdBisect (1.73s)

— watchflakes

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/godebug" && test == "TestCmdBisect"
2025-03-06 16:21 gotip-plan9-arm go@938b6c15 internal/godebug.TestCmdBisect [ABORT] (log) 
=== RUN   TestCmdBisect
*** Test killed with quit: ran too long (49m30s).
signal: killed

— watchflakes

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
post <- pkg == "internal/godebug" && test == "TestCmdBisect"
2025-03-07 19:31 gotip-plan9-386 go@812a44eb internal/godebug.TestCmdBisect (log) 
=== RUN   TestCmdBisect
    godebug_test.go:107: exec bisect: exit status: 'go 7453: 1'
        bisect: checking target with all changes disabled
        bisect: run: GODEBUG=buggy=1#n /home/swarming/luci/386/.swarming/w/ir/x/t/go-build3070523988/b1200/godebug.test -test.run=^TestBisectTestCase$...sys: trap: invalid opcode pc=0x00006121
        PC=0x6121
        
        goroutine 1 gp=0x406248 m=0 mp=0x1a0e40 [running]:
        internal/runtime/maps.(*table).rehash(0xce580, 0x6, 0x41e2a0)
        	/home/swarming/luci/386/.swarming/w/ir/x/w/goroot/src/internal/runtime/maps/table.go:1026 +0x21 fp=0x44cb28 sp=0x44cb14 pc=0x6121
        runtime: g 1: unexpected return pc for internal/runtime/maps.(*table).rehash called from 0x47c030
...
        si    0x80800000
        bp    0x48400e
        sp    0x44cb14
        pc    0x6121
        flags 0x10203
        cs    0x23
        fs    0x1b
        gs    0x1b
        exit status: 'bisect 7477: sys: trap: invalid opcode pc=0x00006121'
--- FAIL: TestCmdBisect (1.15s)

— watchflakes

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
compiler/runtime Issues related to the Go compiler and/or runtime. NeedsInvestigation Someone must examine and confirm this is a valid issue and not a duplicate of an existing one.
Projects
Go Compiler / Runtime
Status: In Progress
Test Flakes
Status: Done
Milestone
No milestone
Development

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