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

cmd/cgo/internal/testcarchive: TestManyCalls failures #67566

Open
gopherbot opened this issue May 21, 2024 · 20 comments
Open

cmd/cgo/internal/testcarchive: TestManyCalls failures #67566

gopherbot opened this issue May 21, 2024 · 20 comments
Assignees
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.
Milestone

Comments

@gopherbot
Copy link
Contributor

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"

Issue created automatically to collect these failures.

Example (log):

=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build2815952951=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2671988462/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.87s)

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 21, 2024
@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-05-21 22:34 gotip-linux-amd64-longtest go@4b778470 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build2815952951=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2671988462/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.87s)

watchflakes

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-05-22 09:58 gotip-linux-amd64-longtest go@cd41d717 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1168042934=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test224014420/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.41s)
2024-05-22 14:20 gotip-linux-amd64-longtest go@1d3d7d39 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1182557413=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2972530068/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.87s)

watchflakes

@cherrymui
Copy link
Member

There are more flaky failures on this since June 20, https://ci.chromium.org/ui/test/golang/cmd%2Fcgo%2Finternal%2Ftestcarchive.TestManyCalls?q=V%3Abuilder%3Dgotip-linux-amd64-longtest-test_only+V%3Ago_branch%3Dmaster+V%3Agoarch%3Damd64+V%3Agoos%3Dlinux+V%3Ahost_goarch%3Damd64+V%3Ahost_goos%3Dlinux
which were matched to #61069.

Tentatively mark as a release blocker, as the high-rate flaky failures seem to start recently.

@cherrymui cherrymui added compiler/runtime Issues related to the Go compiler and/or runtime. release-blocker labels Jul 15, 2024
@cherrymui cherrymui added this to the Go1.23 milestone Jul 15, 2024
@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-06-21 19:58 gotip-linux-386-longtest go@d79c3509 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m32 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build2379281893=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test846712421/pkg/linux_386_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.81s)
2024-06-21 19:58 gotip-linux-amd64-longtest go@d79c3509 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1297635274=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test3111046110/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (67.66s)
2024-06-21 20:30 gotip-linux-amd64-longtest go@cb3b3434 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1392598236=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test193818245/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (65.80s)
2024-06-22 00:00 gotip-linux-amd64-longtest go@44f18706 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build4194400131=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test403248468/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (64.24s)
2024-06-24 15:28 gotip-linux-amd64-longtest go@085cf0fc cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build2761594464=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test3551687877/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.88s)
2024-06-24 15:33 gotip-linux-amd64-longtest go@0def9d5c cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build82568437=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test3040444538/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.78s)
2024-06-24 16:39 gotip-linux-386-longtest go@b98803e8 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m32 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3932238390=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test3639547755/pkg/linux_386_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (62.18s)
2024-06-24 16:39 gotip-linux-amd64-longtest go@b98803e8 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build332999988=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test1393194044/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (67.59s)
2024-06-24 17:52 go1.22-linux-amd64-longtest release-branch.go1.22@3560cf0a cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build2672286316=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test431803681/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (65.47s)
2024-06-24 18:55 gotip-linux-amd64-longtest go@f214a760 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3021580691=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test480891144/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.32s)
2024-06-24 21:07 gotip-linux-amd64-longtest go@68315bc8 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build552437588=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2734782223/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (65.56s)
2024-06-26 16:10 gotip-linux-amd64-longtest go@a2e90be9 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build2993139507=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test315953837/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.60s)
2024-06-27 17:41 gotip-linux-amd64-longtest go@ea537cca cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1970432366=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2499208346/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.85s)
2024-06-28 15:25 gotip-linux-amd64-longtest go@7f90b960 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1348995302=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test464773713/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (67.19s)
2024-06-28 19:59 gotip-linux-amd64-longtest go@82c371a3 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build4134761125=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test513351738/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (67.46s)
2024-07-01 14:58 gotip-linux-amd64-longtest go@d3c93f2f cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build533927821=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test521971101/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.27s)
2024-07-02 18:51 go1.22-linux-amd64-longtest release-branch.go1.22@8e1fdea8 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1448477477=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test6028936/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.27s)
2024-07-03 00:14 gotip-linux-amd64-longtest go@148755a2 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build920887134=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2646131870/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (65.31s)
2024-07-03 13:03 gotip-linux-amd64-longtest go@71f9dbb1 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build2328236361=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2690339460/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (67.33s)
2024-07-07 16:40 gotip-linux-amd64-longtest go@d0146bd8 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build593565273=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test3769716976/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (69.24s)
2024-07-07 19:43 gotip-linux-amd64-longtest go@b43d6c57 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1780134935=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test90360660/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (64.58s)
2024-07-08 00:05 gotip-linux-amd64-longtest go@6d89b38e cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3998046951=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2189679450/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (65.88s)
2024-07-10 02:44 gotip-linux-amd64-longtest go@70e453b4 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1749024690=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test765026489/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.41s)
2024-07-10 03:19 gotip-linux-386-longtest go@b3040679 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m32 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build257476081=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test1248722746/pkg/linux_386_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (62.11s)
2024-07-10 19:27 go1.22-linux-amd64-longtest release-branch.go1.22@49906f95 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1981229932=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test187455808/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.52s)
2024-07-10 19:29 go1.22-linux-amd64-longtest release-branch.go1.22@45f9ded1 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build4188300449=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2204560682/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.96s)
2024-07-11 15:01 gotip-linux-amd64-longtest go@08a6e080 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build406361605=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2219636962/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (65.48s)
2024-07-11 15:01 gotip-linux-amd64-longtest go@611f18c4 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3609333747=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test74597656/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (67.31s)
2024-07-11 17:23 gotip-linux-amd64-longtest go@a71bb570 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1875363026=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test3248917447/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (67.10s)
2024-07-12 22:42 gotip-linux-amd64-longtest go@071b8d51 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3625069990=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2910945480/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.52s)

watchflakes

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-07-09 16:14 go1.23-linux-386-longtest release-branch.go1.23@e89e880e cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m32 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build490386741=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test3752947999/pkg/linux_386_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.11s)
2024-07-09 16:14 go1.23-linux-amd64-longtest release-branch.go1.23@e89e880e cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3583602013=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2109964676/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (67.01s)
2024-07-12 22:42 go1.23-linux-amd64-longtest release-branch.go1.23@071b8d51 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3851497827=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test150421289/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (65.38s)

watchflakes

@cherrymui
Copy link
Member

I pulled the test timing data from LUCI.
timing_master
So it seems the test timing was pretty steadily <20 seconds, then it starts rising since d881ed6, up to 180ea45 which is 50+ seconds. At afbbc28 it drops back to mostly <30 seconds (with few exceptions), until d79c350 it rises again.

For the first elevated period, as afbbc28 is a revert of d881ed6, it is likely that d881ed6 is the cause and the revert fixes it.

For the second elevation, d79c350 is unrelated, so are a few commits nearby. So it is probably something else. Maybe builder change?

Then I pulled the test timing data for the 1.22 release branch, which doesn't have any of those commits.
timing_go122
It seems the timing also rises since June 24, on 3560cf0. The commit might be related, but the corresponding master branch CL landed on May 15, which did not cause the time rising. As the rising on on the release branch is about the same time as on the master branch, I'm more leaning towards builder configuration change. @mknyszek is there any builder configuration change at the time around June 24 or so?

Lastly, the test has a hard-coded 1 minute timeout. I don't think it makes much sense to say 55 seconds is pass, 65 seconds is fail. So the 1 minute timeout may be a bit arbitrary. We probably want to replace it with t.Deadline.

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-07-16 18:02 gotip-linux-amd64-longtest go@5c7f5413 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build27128390=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test1476725237/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (68.14s)
2024-07-16 18:17 gotip-linux-amd64-longtest go@b4a92f56 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1793352452=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2116150728/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.29s)
2024-07-16 18:17 gotip-linux-amd64-longtest go@97ccc224 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build2797306960=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test478452091/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.22s)

watchflakes

@gopherbot
Copy link
Contributor Author

Change https://go.dev/cl/599056 mentions this issue: cmd/cgo/internal/testcarchive: remove 1-minute timeout

gopherbot pushed a commit that referenced this issue Jul 17, 2024
The 1-minute test timeout seems a bit arbitrary. Use
internal/testenv.Command, which applies t.Deadline to subcommand.

For #67566.

Change-Id: If84c96e353bdfaf02c9b123758198e031305ae32
Reviewed-on: https://go-review.googlesource.com/c/go/+/599056
LUCI-TryBot-Result: Go LUCI <golang-scoped@luci-project-accounts.iam.gserviceaccount.com>
Reviewed-by: Dmitri Shuralyov <dmitshur@golang.org>
Reviewed-by: Dmitri Shuralyov <dmitshur@google.com>
@cherrymui
Copy link
Member

CL https://go.dev/cl/599056 replaced the 1-minute timeout with the test deadline. Hopefully this will stop the failures on the builder. At this point I think the test slowdown is more likely due to builder infrastructure change, not the code change in the main repo (which we're going to release). Also, the test was written to catch deadlocks, not speed. Finishing in more than a minute is still deadlock. So at this point I think it is not a release blocker.

It would be great we can understand the slowdown, though. So keep the issue open.

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-07-17 15:08 gotip-linux-amd64-longtest go@fc51e502 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1793085982=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test4229948996/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (69.15s)

watchflakes

@dmitshur dmitshur moved this to Active in Test Flakes Jul 22, 2024
@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-07-15 21:12 go1.23-linux-amd64-longtest release-branch.go1.23@959b3fd4 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build251303856=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test1093062480/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.79s)
2024-07-16 15:33 go1.23-linux-386-longtest release-branch.go1.23@30b6fd60 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m32 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1143598948=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test1430586388/pkg/linux_386_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (64.45s)
2024-07-16 15:33 go1.23-linux-amd64-longtest release-branch.go1.23@30b6fd60 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build4013150068=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test786127661/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (64.85s)
2024-07-16 18:03 go1.23-linux-amd64-longtest release-branch.go1.23@d5479e19 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1938796222=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test4197566412/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.49s)
2024-07-16 18:17 go1.23-linux-amd64-longtest release-branch.go1.23@b4a92f56 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3160472699=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test360819048/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (64.08s)
2024-07-16 18:17 go1.23-linux-amd64-longtest release-branch.go1.23@0dae393a cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3121697396=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test3722246361/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (67.26s)
2024-07-16 18:17 go1.23-linux-amd64-longtest release-branch.go1.23@66e940b6 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build2958702970=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test3527803476/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.18s)
2024-07-16 18:17 go1.23-linux-amd64-longtest release-branch.go1.23@97ccc224 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3835752965=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test395184242/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (66.38s)
2024-07-17 15:08 go1.23-linux-amd64-longtest release-branch.go1.23@fc51e502 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build1367131423=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test1568721262/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (65.57s)

watchflakes

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-07-17 22:41 go1.22-linux-amd64-longtest release-branch.go1.22@4c50f916 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3666840444=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2147441518/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (64.26s)

watchflakes

@cherrymui
Copy link
Member

cherrymui commented Jul 24, 2024

All failures are on the release branches before CL 599056.

@mknyszek mknyszek self-assigned this Jul 24, 2024
@mknyszek
Copy link
Contributor

I'll double-check that there weren't any builder configuration changes around the dates where the test time went up really high.

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-07-31 16:13 go1.22-linux-amd64-longtest release-branch.go1.22@8c8adffd cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build2955289964=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2559971744/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (64.07s)

watchflakes

@gopherbot gopherbot modified the milestones: Go1.23, Go1.24 Aug 13, 2024
@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-08-14 17:44 go1.22-linux-amd64-longtest release-branch.go1.22@0a525a3e cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build4060286399=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test336738103/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (64.59s)
2024-08-21 18:15 go1.22-linux-amd64-longtest release-branch.go1.22@676d6100 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3607727662=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test2638496299/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (63.43s)

watchflakes

@gopherbot
Copy link
Contributor Author

Found new dashboard test flakes for:

#!watchflakes
default <- pkg == "cmd/cgo/internal/testcarchive" && test == "TestManyCalls"
2024-09-05 22:14 go1.22-linux-amd64-longtest release-branch.go1.22@71655f14 cmd/cgo/internal/testcarchive.TestManyCalls (log)
=== RUN   TestManyCalls
=== PAUSE TestManyCalls
=== CONT  TestManyCalls
    carchive_test.go:1209: [go build -buildmode=c-archive -o libgo7.a ./libgo7]
    carchive_test.go:1221: [gcc -fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/home/swarming/.swarming/w/ir/x/t/go-build3208573476=/tmp/go-build -gno-record-gcc-switches -I /home/swarming/.swarming/w/ir/x/t/carchive_test68753648/pkg/linux_amd64_shared/testcarchive -o testp7 main7.c libgo7.a]
    carchive_test.go:1237: test program timed out
    carchive_test.go:1244: [./testp7]
    carchive_test.go:1246: signal: killed
--- FAIL: TestManyCalls (64.85s)

watchflakes

@prattmic
Copy link
Member

@gopherbot Please backport to 1.22 and 1.23. This is a test-only fix for a flaky test that is regularly flaky on the release branches.

@gopherbot
Copy link
Contributor Author

Backport issue(s) opened: #70124 (for 1.22), #70125 (for 1.23).

Remember to create the cherry-pick CL(s) as soon as the patch is submitted to master, according to https://go.dev/wiki/MinorReleases.

@gopherbot
Copy link
Contributor Author

Change https://go.dev/cl/623595 mentions this issue: [release-branch.go1.22] cmd/cgo/internal/testcarchive: remove 1-minute timeout

gopherbot pushed a commit that referenced this issue Oct 31, 2024
…e timeout

The 1-minute test timeout seems a bit arbitrary. Use
internal/testenv.Command, which applies t.Deadline to subcommand.

For #67566.
Fixes #70124.

Change-Id: If84c96e353bdfaf02c9b123758198e031305ae32
Reviewed-on: https://go-review.googlesource.com/c/go/+/599056
LUCI-TryBot-Result: Go LUCI <golang-scoped@luci-project-accounts.iam.gserviceaccount.com>
Reviewed-by: Dmitri Shuralyov <dmitshur@golang.org>
Reviewed-by: Dmitri Shuralyov <dmitshur@google.com>
(cherry picked from commit 8c88f0c)
Reviewed-on: https://go-review.googlesource.com/c/go/+/623595
Reviewed-by: Cherry Mui <cherryyz@google.com>
@dmitshur dmitshur modified the milestones: Go1.24, Backlog Jan 18, 2025
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
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
Status: Active
Development

No branches or pull requests

5 participants