#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
Issue created automatically to collect these failures.
Example (log):
=== RUN TestWithPebble/TLSALPN01-Issuance
=== PAUSE TestWithPebble/TLSALPN01-Issuance
=== CONT TestWithPebble/TLSALPN01-Issuance
pebble_test.go:738: fetching github.com/letsencrypt/pebble/v2@v2.7.0
2025/06/30 16:57:02 building pebble
2025/06/30 16:57:02 building pebble
2025/06/30 16:57:08 building pebble-challtestsrv
2025/06/30 16:57:08 building pebble-challtestsrv
2025/06/30 16:57:09 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0
2025/06/30 16:57:09 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-2189757696.json
...
--- FAIL: TestWithPebble/TLSALPN01-Issuance (12.15s)
Pebble 2025/06/30 16:57:14 Attempting to validate w/ HTTP: http://www.example.com:5563/.well-known/acme-challenge/9pKW3-BNiyGADjsBLLssgMJU7NOsj2p-KB7USW5BaZg
2025/06/30 16:57:14 challHTTPServer: handling GET to /.well-known/acme-challenge/9pKW3-BNiyGADjsBLLssgMJU7NOsj2p-KB7USW5BaZg from 127.0.0.1:45072
Pebble 2025/06/30 16:57:14 authz u6XDpOVcxLywFZxSg38zrNiFfwYEdCnWAi_PP4dR3ZE set VALID by completed challenge oDgy7Bm_o0MOhl_0ieX-tebLE2IruftQNEOmvmyRJ8Y
Pebble 2025/06/30 16:57:14 HEAD /nonce-plz -> calling handler()
Pebble 2025/06/30 16:57:14 POST /my-order/ -> calling handler()
Pebble 2025/06/30 16:57:15 Attempting to validate w/ HTTP: http://example.com:5563/.well-known/acme-challenge/ytz3lru4wbL8mmJ0alOaLun7Og972gP0e10JIQroKq8
Pebble 2025/06/30 16:57:15 Attempting to validate w/ HTTP: http://example.com:5563/.well-known/acme-challenge/ytz3lru4wbL8mmJ0alOaLun7Og972gP0e10JIQroKq8
Pebble 2025/06/30 16:57:15 Attempting to validate w/ HTTP: http://example.com:5563/.well-known/acme-challenge/ytz3lru4wbL8mmJ0alOaLun7Og972gP0e10JIQroKq8
2025/06/30 16:57:15 challHTTPServer: handling GET to /.well-known/acme-challenge/ytz3lru4wbL8mmJ0alOaLun7Og972gP0e10JIQroKq8 from 127.0.0.1:45084
...
Pebble 2025/06/30 16:57:16 HEAD /nonce-plz -> calling handler()
Pebble 2025/06/30 16:57:16 POST /my-order/ -> calling handler()
Pebble 2025/06/30 16:57:16 POST /finalize-order/ -> calling handler()
Pebble 2025/06/30 16:57:17 Order vL_TAV0AbFqRA6j3fBF7Pr8UigKYEOZNpUvYf7INAcY is fully authorized. Processing finalization
Pebble 2025/06/30 16:57:17 POST /my-order/ -> calling handler()
Pebble 2025/06/30 16:57:17 Issued certificate serial 5c36a53a9b55f03b for order vL_TAV0AbFqRA6j3fBF7Pr8UigKYEOZNpUvYf7INAcY
Pebble 2025/06/30 16:57:22 POST /my-order/ -> calling handler()
Pebble 2025/06/30 16:57:22 POST /certZ/ -> calling handler()
2025/06/30 16:57:22 verified 1 path(s) from issued leaf certificate to Pebble root CA
2025/06/30 16:57:22 challHTTPServer: shutting down
Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-06-30 16:51 x_crypto-go1.23-linux-386-longtest crypto@1dc42696 release-branch.go1.23@e919b332 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:738: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/06/30 16:57:02 building pebble 2025/06/30 16:57:02 building pebble 2025/06/30 16:57:08 building pebble-challtestsrv 2025/06/30 16:57:08 building pebble-challtestsrv 2025/06/30 16:57:09 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/06/30 16:57:09 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-2189757696.json ... --- FAIL: TestWithPebble/TLSALPN01-Issuance (12.15s) Pebble 2025/06/30 16:57:14 Attempting to validate w/ HTTP: http://www.example.com:5563/.well-known/acme-challenge/9pKW3-BNiyGADjsBLLssgMJU7NOsj2p-KB7USW5BaZg 2025/06/30 16:57:14 challHTTPServer: handling GET to /.well-known/acme-challenge/9pKW3-BNiyGADjsBLLssgMJU7NOsj2p-KB7USW5BaZg from 127.0.0.1:45072 Pebble 2025/06/30 16:57:14 authz u6XDpOVcxLywFZxSg38zrNiFfwYEdCnWAi_PP4dR3ZE set VALID by completed challenge oDgy7Bm_o0MOhl_0ieX-tebLE2IruftQNEOmvmyRJ8Y Pebble 2025/06/30 16:57:14 HEAD /nonce-plz -> calling handler() Pebble 2025/06/30 16:57:14 POST /my-order/ -> calling handler() Pebble 2025/06/30 16:57:15 Attempting to validate w/ HTTP: http://example.com:5563/.well-known/acme-challenge/ytz3lru4wbL8mmJ0alOaLun7Og972gP0e10JIQroKq8 Pebble 2025/06/30 16:57:15 Attempting to validate w/ HTTP: http://example.com:5563/.well-known/acme-challenge/ytz3lru4wbL8mmJ0alOaLun7Og972gP0e10JIQroKq8 Pebble 2025/06/30 16:57:15 Attempting to validate w/ HTTP: http://example.com:5563/.well-known/acme-challenge/ytz3lru4wbL8mmJ0alOaLun7Og972gP0e10JIQroKq8 2025/06/30 16:57:15 challHTTPServer: handling GET to /.well-known/acme-challenge/ytz3lru4wbL8mmJ0alOaLun7Og972gP0e10JIQroKq8 from 127.0.0.1:45084 ... Pebble 2025/06/30 16:57:16 HEAD /nonce-plz -> calling handler() Pebble 2025/06/30 16:57:16 POST /my-order/ -> calling handler() Pebble 2025/06/30 16:57:16 POST /finalize-order/ -> calling handler() Pebble 2025/06/30 16:57:17 Order vL_TAV0AbFqRA6j3fBF7Pr8UigKYEOZNpUvYf7INAcY is fully authorized. Processing finalization Pebble 2025/06/30 16:57:17 POST /my-order/ -> calling handler() Pebble 2025/06/30 16:57:17 Issued certificate serial 5c36a53a9b55f03b for order vL_TAV0AbFqRA6j3fBF7Pr8UigKYEOZNpUvYf7INAcY Pebble 2025/06/30 16:57:22 POST /my-order/ -> calling handler() Pebble 2025/06/30 16:57:22 POST /certZ/ -> calling handler() 2025/06/30 16:57:22 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/06/30 16:57:22 challHTTPServer: shutting downComment From: sigmavirus24
cc @cpu
Comment From: gopherbot
Change https://go.dev/cl/686935 mentions this issue: acme: capture pebble test subprocess stdout/stderr
Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-06-30 16:51 x_crypto-go1.24-linux-386-longtest crypto@1dc42696 release-branch.go1.24@dbf30d88 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:738: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/06/30 16:57:20 building pebble 2025/06/30 16:57:20 building pebble 2025/06/30 16:57:26 building pebble-challtestsrv 2025/06/30 16:57:26 building pebble-challtestsrv 2025/06/30 16:57:27 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/06/30 16:57:27 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-529688877.json ... --- FAIL: TestWithPebble/TLSALPN01-Issuance (12.37s) Pebble 2025/06/30 16:57:32 Attempting to validate w/ HTTP: http://www.example.com:5557/.well-known/acme-challenge/v1c-SbdwzpENJMwV5--elpEO0YG-pY0ogdTKJDVD6-g 2025/06/30 16:57:32 challHTTPServer: handling GET to /.well-known/acme-challenge/v1c-SbdwzpENJMwV5--elpEO0YG-pY0ogdTKJDVD6-g from 127.0.0.1:58394 Pebble 2025/06/30 16:57:32 authz HXuoTf8LFq8txiWVm3e2LBpxRJ_WeMUcDawuSQkIXzA set VALID by completed challenge d11zaIOKnjxvVflNi2c0CrAKkFdbpXVJEYP15sWN9v4 Pebble 2025/06/30 16:57:32 POST /my-order/ -> calling handler() Pebble 2025/06/30 16:57:33 Attempting to validate w/ HTTP: http://example.com:5557/.well-known/acme-challenge/9M3HiJbiYKsL4k6IuUZ_Rm9vNKzO9SlA6PgSnfeUxIw 2025/06/30 16:57:33 challHTTPServer: handling GET to /.well-known/acme-challenge/9M3HiJbiYKsL4k6IuUZ_Rm9vNKzO9SlA6PgSnfeUxIw from 127.0.0.1:33080 Pebble 2025/06/30 16:57:33 POST /my-order/ -> calling handler() Pebble 2025/06/30 16:57:34 Attempting to validate w/ HTTP: http://example.com:5557/.well-known/acme-challenge/9M3HiJbiYKsL4k6IuUZ_Rm9vNKzO9SlA6PgSnfeUxIw 2025/06/30 16:57:34 challHTTPServer: handling GET to /.well-known/acme-challenge/9M3HiJbiYKsL4k6IuUZ_Rm9vNKzO9SlA6PgSnfeUxIw from 127.0.0.1:33086 Pebble 2025/06/30 16:57:34 authz sMovl9Fe0QfSX_XQ6KgbtfCFvvYgwGZiezvCHzqnziY set VALID by completed challenge MAzcPg5yCLKWIUpqvihhxbjMAjTpAFdCuOq0fvx_cuI Pebble 2025/06/30 16:57:34 POST /my-order/ -> calling handler() Pebble 2025/06/30 16:57:34 POST /finalize-order/ -> calling handler() Pebble 2025/06/30 16:57:34 Order rD6iyEO8_scFOogpNB6Ve8zxhDRCxM12eT4XFadlVK0 is fully authorized. Processing finalization Pebble 2025/06/30 16:57:34 POST /my-order/ -> calling handler() Pebble 2025/06/30 16:57:34 Issued certificate serial 6b2eae36f713be08 for order rD6iyEO8_scFOogpNB6Ve8zxhDRCxM12eT4XFadlVK0 Pebble 2025/06/30 16:57:39 POST /my-order/ -> calling handler() Pebble 2025/06/30 16:57:39 POST /certZ/ -> calling handler() 2025/06/30 16:57:39 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/06/30 16:57:39 challHTTPServer: shutting down2025-06-30 19:50 x_crypto-go1.24-linux-386-longtest crypto@b3790b8d release-branch.go1.24@9d828e80 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/07/08 17:04:41 building pebble 2025/07/08 17:04:41 building pebble 2025/07/08 17:04:47 building pebble-challtestsrv 2025/07/08 17:04:47 building pebble-challtestsrv 2025/07/08 17:04:48 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/07/08 17:04:48 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-530343293.json ... --- FAIL: TestWithPebble/TLSALPN01-Issuance (12.18s) Pebble 2025/07/08 17:04:53 Attempting to validate w/ HTTP: http://www.example.com:5563/.well-known/acme-challenge/S0kGMnj54qIWpiJUtAxIVcXdfXHjgFWf7QY281uaoa8 2025/07/08 17:04:53 challHTTPServer: handling GET to /.well-known/acme-challenge/S0kGMnj54qIWpiJUtAxIVcXdfXHjgFWf7QY281uaoa8 from 127.0.0.1:51724 Pebble 2025/07/08 17:04:53 authz bu7fJST9OnTjf4wRkpZ9_lhCluW3To2y5eD-cCH1ous set VALID by completed challenge 0ye-OJKiSw_fAoXvKQI4I3x9FQE6jnyHSSf4-uN0swA Pebble 2025/07/08 17:04:53 Attempting to validate w/ HTTP: http://127.0.0.1:5563/.well-known/acme-challenge/DtkeMn6JKYsFek9lSfjKKM1GFAdUPvElYyNhTqJFvnA 2025/07/08 17:04:53 challHTTPServer: handling GET to /.well-known/acme-challenge/DtkeMn6JKYsFek9lSfjKKM1GFAdUPvElYyNhTqJFvnA from 127.0.0.1:51726 Pebble 2025/07/08 17:04:53 authz C0xlWtAmHKlnEM7YlhE_OlTyedcv6iB6dq1gqGDPHGg set VALID by completed challenge DBlXXs6oKvdz44JTnThKziO63JsZ8DeFWj94hJrY300 Pebble 2025/07/08 17:04:53 POST /my-order/ -> calling handler() Pebble 2025/07/08 17:04:53 POST /finalize-order/ -> calling handler() Pebble 2025/07/08 17:04:53 Order rpKUh6f15TeK5ETs7--fBP-aABSrU2gqfat4-DC6Rrw is fully authorized. Processing finalization Pebble 2025/07/08 17:04:53 POST /my-order/ -> calling handler() Pebble 2025/07/08 17:04:53 Issued certificate serial 203f600784d6ef2a for order rpKUh6f15TeK5ETs7--fBP-aABSrU2gqfat4-DC6Rrw Pebble 2025/07/08 17:04:58 POST /my-order/ -> calling handler() Pebble 2025/07/08 17:04:58 POST /certZ/ -> calling handler() 2025/07/08 17:04:58 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/07/08 17:04:58 challHTTPServer: shutting downComment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-07-11 19:27 x_crypto-go1.23-linux-386-longtest crypto@b903b535 release-branch.go1.23@8fa31a2d x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/07/30 20:44:23 building pebble 2025/07/30 20:44:23 building pebble 2025/07/30 20:44:28 building pebble-challtestsrv 2025/07/30 20:44:28 building pebble-challtestsrv 2025/07/30 20:44:29 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/07/30 20:44:29 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-494816571.json ... pebble_test.go:796: stdout: Running in strict mode Pebble 2025/07/30 20:44:29 Starting Pebble ACME server --- FAIL: TestWithPebble/TLSALPN01-Issuance (10.56s) 2025/07/30 20:44:33 challHTTPServer: handling GET to /.well-known/acme-challenge/tKbP-nPCjKNV8sheRuco02ncj5O6_dv-jA6pdIq_5kU from 127.0.0.1:49744 2025/07/30 20:44:33 challHTTPServer: handling GET to /.well-known/acme-challenge/mArcpMW5Q3GofYezZxzzEzyufWF6bq9-H9nSMRk17Rk from 127.0.0.1:49746 2025/07/30 20:44:34 challHTTPServer: handling GET to /.well-known/acme-challenge/tKbP-nPCjKNV8sheRuco02ncj5O6_dv-jA6pdIq_5kU from 127.0.0.1:57828 2025/07/30 20:44:36 challHTTPServer: handling GET to /.well-known/acme-challenge/McyB7tj3PDWRakjArsJVcG_YK8i28YXeVM04DuMcYpc from 127.0.0.1:57830 2025/07/30 20:44:41 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/07/30 20:44:41 challHTTPServer: shutting down2025-07-11 19:27 x_crypto-go1.24-linux-386-longtest crypto@b903b535 release-branch.go1.24@0f5133b7 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:96: failed to connect to "127.0.0.1:5555" after 10 tries pebble_test.go:794: === pebble-challtestsrv output === pebble_test.go:796: stdout: pebble-challtestsrv - 2025/07/30 21:11:45 Creating TCP and UDP DNS-01 challenge server on :5559 pebble-challtestsrv - 2025/07/30 21:11:45 Answering A queries with 127.0.0.1 by default pebble-challtestsrv - 2025/07/30 21:11:45 Starting challenge servers pebble-challtestsrv - 2025/07/30 21:11:45 Starting management server on :5560 pebble_test.go:794: === pebble output === pebble_test.go:796: stdout: Running in strict mode Pebble 2025/07/30 21:11:45 Starting Pebble ACME server --- FAIL: TestWithPebble/TLSALPN01-Issuance (12.51s) 2025/07/30 21:11:50 challHTTPServer: handling GET to /.well-known/acme-challenge/aPf43z46vVslusT5KOlb4_cjJYhSag2J8bZ1fnieTIU from 127.0.0.1:56196 2025/07/30 21:11:50 challHTTPServer: handling GET to /.well-known/acme-challenge/0W4x2p0snEw40L_7hwxDyxAuRQXMwWRCFSgx9_IlWRY from 127.0.0.1:56210 2025/07/30 21:11:51 challHTTPServer: handling GET to /.well-known/acme-challenge/aPf43z46vVslusT5KOlb4_cjJYhSag2J8bZ1fnieTIU from 127.0.0.1:56226 2025/07/30 21:11:51 challHTTPServer: handling GET to /.well-known/acme-challenge/0W4x2p0snEw40L_7hwxDyxAuRQXMwWRCFSgx9_IlWRY from 127.0.0.1:56232 2025/07/30 21:11:51 challHTTPServer: handling GET to /.well-known/acme-challenge/vBgXE3JqjZPwa0ILSx1cJO-4-QWYxVxa45X4nsFxj7k from 127.0.0.1:56248 2025/07/30 21:11:53 challHTTPServer: handling GET to /.well-known/acme-challenge/aPf43z46vVslusT5KOlb4_cjJYhSag2J8bZ1fnieTIU from 127.0.0.1:56284 2025/07/30 21:11:53 challHTTPServer: handling GET to /.well-known/acme-challenge/0W4x2p0snEw40L_7hwxDyxAuRQXMwWRCFSgx9_IlWRY from 127.0.0.1:56290 2025/07/30 21:11:53 challHTTPServer: handling GET to /.well-known/acme-challenge/vBgXE3JqjZPwa0ILSx1cJO-4-QWYxVxa45X4nsFxj7k from 127.0.0.1:56296 2025/07/30 21:11:53 challHTTPServer: handling GET to /.well-known/acme-challenge/vBgXE3JqjZPwa0ILSx1cJO-4-QWYxVxa45X4nsFxj7k from 127.0.0.1:56304 2025/07/30 21:11:58 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/07/30 21:11:58 challHTTPServer: shutting downComment From: gopherbot
Change https://go.dev/cl/692075 mentions this issue: acme: increase pebble test waitForServer attempts
Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-07-11 19:27 x_crypto-go1.23-linux-amd64-longtest-race crypto@b903b535 release-branch.go1.23@8fa31a2d x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 testing.go:1399: race detected during execution of test pebble_test.go:794: === pebble-challtestsrv output === pebble_test.go:796: stdout: pebble-challtestsrv - 2025/07/30 20:42:09 Creating TCP and UDP DNS-01 challenge server on :5565 pebble-challtestsrv - 2025/07/30 20:42:09 Answering A queries with 127.0.0.1 by default pebble-challtestsrv - 2025/07/30 20:42:09 Starting challenge servers ... Pebble 2025/07/30 20:42:17 Order 87N_zkTNy0NOrdYzBWSONBAq50fLQuNWFWpzqwbMACY is fully authorized. Processing finalization Pebble 2025/07/30 20:42:17 POST /my-order/ -> calling handler() Pebble 2025/07/30 20:42:17 Issued certificate serial 71ffceff6d0c781e for order 87N_zkTNy0NOrdYzBWSONBAq50fLQuNWFWpzqwbMACY Pebble 2025/07/30 20:42:22 POST /my-order/ -> calling handler() Pebble 2025/07/30 20:42:22 POST /certZ/ -> calling handler() Pebble 2025/07/30 20:42:23 HEAD /nonce-plz -> calling handler() Pebble 2025/07/30 20:42:23 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/07/30 20:42:10 http: TLS handshake error from 127.0.0.1:53092: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (24.92s)2025-07-11 19:27 x_crypto-go1.24-linux-amd64-longtest-race crypto@b903b535 release-branch.go1.24@0f5133b7 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c000384cc0 by goroutine 578: bytes.(*Buffer).Len() /home/swarming/.swarming/w/ir/x/w/goroot/src/bytes/buffer.go:79 +0x19c ... testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1792 +0x225 testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1851 +0x44 ================== pebble_test.go:799: stderr: 2025/07/30 21:11:44 http: TLS handshake error from 127.0.0.1:37162: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (19.65s) 2025/07/30 21:11:56 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/07/30 21:11:56 challHTTPServer: shutting down2025-07-11 19:27 x_crypto-go1.25-linux-amd64-longtest-race crypto@b903b535 release-branch.go1.25@ebee011a x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/07/30 15:58:49 building pebble 2025/07/30 15:58:49 building pebble 2025/07/30 15:58:59 building pebble-challtestsrv 2025/07/30 15:58:59 building pebble-challtestsrv 2025/07/30 15:59:00 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/07/30 15:59:00 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-1010080965.json ... Pebble 2025/07/30 15:59:06 HEAD /nonce-plz -> calling handler() Pebble 2025/07/30 15:59:06 POST /finalize-order/ -> calling handler() Pebble 2025/07/30 15:59:06 Order CXhnto-5VBLGdMGpaDSJyumEMetAiPdR4nMBQKSU1_k is fully authorized. Processing finalization Pebble 2025/07/30 15:59:06 POST /my-order/ -> calling handler() Pebble 2025/07/30 15:59:06 Issued certificate serial 654906adeaf6e26e for order CXhnto-5VBLGdMGpaDSJyumEMetAiPdR4nMBQKSU1_k Pebble 2025/07/30 15:59:11 POST /my-order/ -> calling handler() Pebble 2025/07/30 15:59:11 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/07/30 15:59:01 http: TLS handshake error from 127.0.0.1:34856: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (22.48s)2025-07-11 19:27 x_crypto-gotip-linux-amd64-longtest-race crypto@b903b535 go@a4d99770 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c000457440 by goroutine 588: bytes.(*Buffer).Len() /home/swarming/.swarming/w/ir/x/w/goroot/src/bytes/buffer.go:85 +0x19c ... golang.org/x/crypto/acme_test.TestWithPebble.func3() /home/swarming/.swarming/w/ir/x/w/targetrepo213181935/acme/pebble_test.go:96 +0x55 testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1934 +0x21c testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1997 +0x38 ================== pebble_test.go:799: stderr: 2025/07/30 21:09:23 http: TLS handshake error from 127.0.0.1:48708: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (20.23s)2025-07-30 23:29 x_crypto-go1.23-linux-amd64-longtest-race crypto@1b4c3d2e release-branch.go1.23@8fa31a2d x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/07/30 23:34:31 building pebble 2025/07/30 23:34:31 building pebble 2025/07/30 23:34:40 building pebble-challtestsrv 2025/07/30 23:34:40 building pebble-challtestsrv 2025/07/30 23:34:41 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/07/30 23:34:41 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-4061289621.json ... Pebble 2025/07/30 23:34:46 POST /my-order/ -> calling handler() Pebble 2025/07/30 23:34:46 POST /finalize-order/ -> calling handler() Pebble 2025/07/30 23:34:46 Order BovoW_OltwTHJ80c76c1FUr_nyZTBTA71O2ie0Yw0k4 is fully authorized. Processing finalization Pebble 2025/07/30 23:34:46 POST /my-order/ -> calling handler() Pebble 2025/07/30 23:34:46 Issued certificate serial 4d0a3848c84b2ae9 for order BovoW_OltwTHJ80c76c1FUr_nyZTBTA71O2ie0Yw0k4 Pebble 2025/07/30 23:34:51 POST /my-order/ -> calling handler() Pebble 2025/07/30 23:34:51 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/07/30 23:34:42 http: TLS handshake error from 127.0.0.1:45414: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (19.76s)2025-07-30 23:29 x_crypto-go1.24-linux-amd64-longtest-race crypto@1b4c3d2e release-branch.go1.24@0f5133b7 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c00039aa80 by goroutine 577: bytes.(*Buffer).Len() /home/swarming/.swarming/w/ir/x/w/goroot/src/bytes/buffer.go:79 +0x19c ... testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1792 +0x225 testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1851 +0x44 ================== pebble_test.go:799: stderr: 2025/07/30 23:34:28 http: TLS handshake error from 127.0.0.1:32902: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (20.24s) 2025/07/30 23:34:40 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/07/30 23:34:40 challHTTPServer: shutting down2025-07-30 23:29 x_crypto-go1.25-linux-amd64-longtest-race crypto@1b4c3d2e release-branch.go1.25@ebee011a x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/07/30 23:34:14 building pebble 2025/07/30 23:34:14 building pebble 2025/07/30 23:34:24 building pebble-challtestsrv 2025/07/30 23:34:24 building pebble-challtestsrv 2025/07/30 23:34:25 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/07/30 23:34:25 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-4162512935.json ... Pebble 2025/07/30 23:34:28 POST /my-order/ -> calling handler() Pebble 2025/07/30 23:34:28 Issued certificate serial 074e29560a9d911b for order h4xn4c4BjWhZPWzQOpcDv1C8rzYMfDfn0Fy2c_OimjA Pebble 2025/07/30 23:34:30 HEAD /nonce-plz -> calling handler() Pebble 2025/07/30 23:34:30 POST /my-order/ -> calling handler() Pebble 2025/07/30 23:34:30 POST /certZ/ -> calling handler() Pebble 2025/07/30 23:34:31 HEAD /nonce-plz -> calling handler() Pebble 2025/07/30 23:34:31 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/07/30 23:34:25 http: TLS handshake error from 127.0.0.1:36478: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (17.32s)2025-07-30 23:29 x_crypto-gotip-linux-amd64-longtest-race crypto@1b4c3d2e go@eb7f515c x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c0002e3920 by goroutine 587: bytes.(*Buffer).Len() /home/swarming/.swarming/w/ir/x/w/goroot/src/bytes/buffer.go:85 +0x19c ... testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1934 +0x21c testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1997 +0x38 ================== pebble_test.go:799: stderr: 2025/08/01 00:25:10 http: TLS handshake error from 127.0.0.1:41002: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (20.38s) 2025/08/01 00:25:20 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/08/01 00:25:20 challHTTPServer: shutting down2025-08-01 15:44 x_crypto-go1.23-linux-amd64-longtest-race crypto@1fda7315 release-branch.go1.23@8fa31a2d x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 testing.go:1399: race detected during execution of test pebble_test.go:794: === pebble-challtestsrv output === pebble_test.go:796: stdout: pebble-challtestsrv - 2025/08/01 15:49:46 Creating TCP and UDP DNS-01 challenge server on :5565 pebble-challtestsrv - 2025/08/01 15:49:46 Answering A queries with 127.0.0.1 by default pebble-challtestsrv - 2025/08/01 15:49:46 Starting challenge servers ... Pebble 2025/08/01 15:49:54 POST /my-order/ -> calling handler() Pebble 2025/08/01 15:49:54 POST /finalize-order/ -> calling handler() Pebble 2025/08/01 15:49:54 Order nMrjUvr133w-Io29-vgVwgXeLmUts8tK3JUkfyNO0cw is fully authorized. Processing finalization Pebble 2025/08/01 15:49:54 POST /my-order/ -> calling handler() Pebble 2025/08/01 15:49:54 Issued certificate serial 7e08b0696415c0cb for order nMrjUvr133w-Io29-vgVwgXeLmUts8tK3JUkfyNO0cw Pebble 2025/08/01 15:49:59 POST /my-order/ -> calling handler() Pebble 2025/08/01 15:49:59 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/01 15:49:47 http: TLS handshake error from 127.0.0.1:52646: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (26.65s)2025-08-01 15:44 x_crypto-go1.24-linux-amd64-longtest-race crypto@1fda7315 release-branch.go1.24@0f5133b7 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/01 15:48:37 building pebble 2025/08/01 15:48:37 building pebble 2025/08/01 15:48:48 building pebble-challtestsrv 2025/08/01 15:48:48 building pebble-challtestsrv 2025/08/01 15:48:49 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/01 15:48:49 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-580828130.json ... Pebble 2025/08/01 15:48:54 Order 6OZqVFzKQcKOeEMtk3cQhXM-ZQgD95e89rfeNP5lgEE is fully authorized. Processing finalization Pebble 2025/08/01 15:48:54 POST /my-order/ -> calling handler() Pebble 2025/08/01 15:48:54 Issued certificate serial 72f06bcd636dec28 for order 6OZqVFzKQcKOeEMtk3cQhXM-ZQgD95e89rfeNP5lgEE Pebble 2025/08/01 15:48:59 POST /my-order/ -> calling handler() Pebble 2025/08/01 15:48:59 POST /certZ/ -> calling handler() Pebble 2025/08/01 15:49:00 HEAD /nonce-plz -> calling handler() Pebble 2025/08/01 15:49:00 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/01 15:48:50 http: TLS handshake error from 127.0.0.1:41158: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (23.84s)2025-08-01 15:44 x_crypto-go1.25-linux-amd64-longtest-race crypto@1fda7315 release-branch.go1.25@ebee011a x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 testing.go:1617: race detected during execution of test pebble_test.go:794: === pebble-challtestsrv output === pebble_test.go:796: stdout: pebble-challtestsrv - 2025/08/01 15:49:32 Creating TCP and UDP DNS-01 challenge server on :5559 pebble-challtestsrv - 2025/08/01 15:49:32 Answering A queries with 127.0.0.1 by default pebble-challtestsrv - 2025/08/01 15:49:32 Starting challenge servers ... Pebble 2025/08/01 15:49:36 POST /my-order/ -> calling handler() Pebble 2025/08/01 15:49:36 POST /finalize-order/ -> calling handler() Pebble 2025/08/01 15:49:36 Order qYqOa49FlGfP3Azu-SsAlpr6_3fPuDbLYQBBQAI8-D4 is fully authorized. Processing finalization Pebble 2025/08/01 15:49:36 POST /my-order/ -> calling handler() Pebble 2025/08/01 15:49:36 Issued certificate serial 20f0ce19d695e452 for order qYqOa49FlGfP3Azu-SsAlpr6_3fPuDbLYQBBQAI8-D4 Pebble 2025/08/01 15:49:41 POST /my-order/ -> calling handler() Pebble 2025/08/01 15:49:41 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/01 15:49:32 http: TLS handshake error from 127.0.0.1:35154: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (20.86s)2025-08-01 15:44 x_crypto-gotip-linux-amd64-longtest-race crypto@1fda7315 go@4ab1aec0 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/01 19:01:42 building pebble 2025/08/01 19:01:42 building pebble 2025/08/01 19:01:52 building pebble-challtestsrv 2025/08/01 19:01:52 building pebble-challtestsrv 2025/08/01 19:01:53 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/01 19:01:53 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-2225046520.json ... testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1934 +0x21c testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1997 +0x38 ================== pebble_test.go:799: stderr: 2025/08/01 19:01:53 http: TLS handshake error from 127.0.0.1:48082: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (19.92s) 2025/08/01 19:02:08 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/08/01 19:02:08 challHTTPServer: shutting down2025-08-03 19:47 x_crypto-go1.23-linux-amd64-longtest-race crypto@c247dead release-branch.go1.23@8fa31a2d x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 testing.go:1399: race detected during execution of test pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Write at 0x00c0004c4c00 by goroutine 597: bytes.(*Buffer).ReadFrom() ... golang.org/x/crypto/acme_test.TestWithPebble.func3() /home/swarming/.swarming/w/ir/x/w/targetrepo2042135191/acme/pebble_test.go:96 +0x55 testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1690 +0x226 testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1743 +0x44 ================== pebble_test.go:799: stderr: 2025/08/03 19:52:01 http: TLS handshake error from 127.0.0.1:60952: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (19.27s)2025-08-03 19:47 x_crypto-go1.24-linux-amd64-longtest-race crypto@c247dead release-branch.go1.24@0f5133b7 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/03 19:51:59 building pebble 2025/08/03 19:51:59 building pebble 2025/08/03 19:52:09 building pebble-challtestsrv 2025/08/03 19:52:09 building pebble-challtestsrv 2025/08/03 19:52:10 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/03 19:52:10 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-286279251.json ... Pebble 2025/08/03 19:52:15 POST /my-order/ -> calling handler() Pebble 2025/08/03 19:52:15 POST /finalize-order/ -> calling handler() Pebble 2025/08/03 19:52:15 Order 718AGuatH08-96KzGS-D2lZr-17Nt3nRkafkZllhxbM is fully authorized. Processing finalization Pebble 2025/08/03 19:52:15 POST /my-order/ -> calling handler() Pebble 2025/08/03 19:52:15 Issued certificate serial 0a9c5037b2fa8350 for order 718AGuatH08-96KzGS-D2lZr-17Nt3nRkafkZllhxbM Pebble 2025/08/03 19:52:20 POST /my-order/ -> calling handler() Pebble 2025/08/03 19:52:20 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/03 19:52:11 http: TLS handshake error from 127.0.0.1:34818: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (20.91s)2025-08-03 19:47 x_crypto-go1.25-linux-amd64-longtest-race crypto@c247dead release-branch.go1.25@ebee011a x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/03 19:52:02 building pebble 2025/08/03 19:52:02 building pebble 2025/08/03 19:52:13 building pebble-challtestsrv 2025/08/03 19:52:13 building pebble-challtestsrv 2025/08/03 19:52:13 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/03 19:52:13 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-4004521321.json ... /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1934 +0x21c testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1997 +0x44 ================== pebble_test.go:799: stderr: 2025/08/03 19:52:14 http: TLS handshake error from 127.0.0.1:38764: EOF testing.go:1617: race detected during execution of test --- FAIL: TestWithPebble/TLSALPN01-Issuance (19.73s) 2025/08/03 19:52:25 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/08/03 19:52:25 challHTTPServer: shutting down2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@4ab1aec0 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c00029acc0 by goroutine 586: bytes.(*Buffer).Len() /home/swarming/.swarming/w/ir/x/w/goroot/src/bytes/buffer.go:85 +0x19c ... testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1934 +0x21c testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1997 +0x38 ================== pebble_test.go:799: stderr: 2025/08/03 19:52:11 http: TLS handshake error from 127.0.0.1:37786: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (20.55s) 2025/08/03 19:52:21 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/08/03 19:52:21 challHTTPServer: shutting downComment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@d6beda86 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 testing.go:1617: race detected during execution of test pebble_test.go:794: === pebble-challtestsrv output === pebble_test.go:796: stdout: pebble-challtestsrv - 2025/08/04 01:37:23 Creating TCP and UDP DNS-01 challenge server on :5559 pebble-challtestsrv - 2025/08/04 01:37:23 Answering A queries with 127.0.0.1 by default pebble-challtestsrv - 2025/08/04 01:37:23 Starting challenge servers ... Pebble 2025/08/04 01:37:29 POST /my-order/ -> calling handler() Pebble 2025/08/04 01:37:29 POST /finalize-order/ -> calling handler() Pebble 2025/08/04 01:37:29 Order 1048wHc4uLGtvtTg0aljI_TNdVKTrfCKIIeEP267swM is fully authorized. Processing finalization Pebble 2025/08/04 01:37:29 POST /my-order/ -> calling handler() Pebble 2025/08/04 01:37:29 Issued certificate serial 1a3eec126a867949 for order 1048wHc4uLGtvtTg0aljI_TNdVKTrfCKIIeEP267swM Pebble 2025/08/04 01:37:34 POST /my-order/ -> calling handler() Pebble 2025/08/04 01:37:34 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/04 01:37:24 http: TLS handshake error from 127.0.0.1:38882: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (22.90s)Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@b2960e35 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c00025a0f0 by goroutine 584: bytes.(*Buffer).Len() /home/swarming/.swarming/w/ir/x/w/goroot/src/bytes/buffer.go:85 +0x19c ... golang.org/x/crypto/acme_test.TestWithPebble.func3() /home/swarming/.swarming/w/ir/x/w/targetrepo4162479337/acme/pebble_test.go:96 +0x55 testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1934 +0x21c testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1997 +0x38 ================== pebble_test.go:799: stderr: 2025/08/04 01:39:17 http: TLS handshake error from 127.0.0.1:49128: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (22.02s)Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@4b6cbc37 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 testing.go:1617: race detected during execution of test pebble_test.go:794: === pebble-challtestsrv output === pebble_test.go:796: stdout: pebble-challtestsrv - 2025/08/04 16:20:29 Creating TCP and UDP DNS-01 challenge server on :5565 pebble-challtestsrv - 2025/08/04 16:20:29 Answering A queries with 127.0.0.1 by default pebble-challtestsrv - 2025/08/04 16:20:29 Starting management server on :5566 ... Pebble 2025/08/04 16:20:34 POST /my-order/ -> calling handler() Pebble 2025/08/04 16:20:34 POST /finalize-order/ -> calling handler() Pebble 2025/08/04 16:20:34 Order tK2bIbkMlIVSHKdH1I1X1zL1JiPJtXjd2Vx47AY3A1g is fully authorized. Processing finalization Pebble 2025/08/04 16:20:34 POST /my-order/ -> calling handler() Pebble 2025/08/04 16:20:34 Issued certificate serial 734259d8c177ce2a for order tK2bIbkMlIVSHKdH1I1X1zL1JiPJtXjd2Vx47AY3A1g Pebble 2025/08/04 16:20:39 POST /my-order/ -> calling handler() Pebble 2025/08/04 16:20:39 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/04 16:20:30 http: TLS handshake error from 127.0.0.1:43058: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (20.74s)Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@7a1679d7 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 testing.go:1617: race detected during execution of test pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c0003bd170 by goroutine 589: bytes.(*Buffer).Len() ... Pebble 2025/08/04 17:15:28 Order 46e5c2abz52iPD-5FJFDyX0W0OV32pH94bcqOy9saj0 is fully authorized. Processing finalization Pebble 2025/08/04 17:15:28 POST /my-order/ -> calling handler() Pebble 2025/08/04 17:15:28 Issued certificate serial 30d13fa0d0bf21a3 for order 46e5c2abz52iPD-5FJFDyX0W0OV32pH94bcqOy9saj0 Pebble 2025/08/04 17:15:33 POST /my-order/ -> calling handler() Pebble 2025/08/04 17:15:33 POST /certZ/ -> calling handler() Pebble 2025/08/04 17:15:35 HEAD /nonce-plz -> calling handler() Pebble 2025/08/04 17:15:35 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/04 17:15:24 http: TLS handshake error from 127.0.0.1:56006: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (21.85s)Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@2b622b05 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 testing.go:1617: race detected during execution of test pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c00040bef0 by goroutine 587: bytes.(*Buffer).Len() ... Pebble 2025/08/05 15:45:05 POST /my-order/ -> calling handler() Pebble 2025/08/05 15:45:05 POST /finalize-order/ -> calling handler() Pebble 2025/08/05 15:45:05 Order KHToL1pEH-cj_uHfY0eah8Ij0TV1jNCPe1nDMTDlKz4 is fully authorized. Processing finalization Pebble 2025/08/05 15:45:05 POST /my-order/ -> calling handler() Pebble 2025/08/05 15:45:05 Issued certificate serial 4b251536097e26d6 for order KHToL1pEH-cj_uHfY0eah8Ij0TV1jNCPe1nDMTDlKz4 Pebble 2025/08/05 15:45:10 POST /my-order/ -> calling handler() Pebble 2025/08/05 15:45:10 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/05 15:44:59 http: TLS handshake error from 127.0.0.1:48046: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (22.58s)Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@cd55f86b x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/05 16:26:28 building pebble 2025/08/05 16:26:28 building pebble 2025/08/05 16:26:38 building pebble-challtestsrv 2025/08/05 16:26:38 building pebble-challtestsrv 2025/08/05 16:26:39 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/05 16:26:39 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-1859011641.json ... Pebble 2025/08/05 16:26:44 Issued certificate serial 22d31879b7f19de1 for order yW-0fxcJi7BjhCb_b2f4MNJ-6XGTb2FoYQ62Us9uGBg Pebble 2025/08/05 16:26:49 POST /my-order/ -> calling handler() Pebble 2025/08/05 16:26:50 HEAD /nonce-plz -> calling handler() Pebble 2025/08/05 16:26:50 POST /my-order/ -> calling handler() Pebble 2025/08/05 16:26:53 HEAD /nonce-plz -> calling handler() Pebble 2025/08/05 16:26:53 POST /my-order/ -> calling handler() Pebble 2025/08/05 16:26:53 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/05 16:26:39 http: TLS handshake error from 127.0.0.1:36994: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (24.92s)Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@c0025d5e x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/05 17:48:31 building pebble 2025/08/05 17:48:31 building pebble 2025/08/05 17:48:41 building pebble-challtestsrv 2025/08/05 17:48:41 building pebble-challtestsrv 2025/08/05 17:48:42 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/05 17:48:42 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-2490923584.json ... testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1934 +0x21c testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1997 +0x38 ================== pebble_test.go:799: stderr: 2025/08/05 17:48:43 http: TLS handshake error from 127.0.0.1:36148: EOF 2025/08/05 17:48:52 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/08/05 17:48:52 challHTTPServer: shutting down --- FAIL: TestWithPebble/TLSALPN01-Issuance (20.16s)Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@e1fd4faf x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/05 21:40:10 building pebble 2025/08/05 21:40:10 building pebble 2025/08/05 21:40:20 building pebble-challtestsrv 2025/08/05 21:40:20 building pebble-challtestsrv 2025/08/05 21:40:21 pebble dir: /home/swarming/.swarming/w/ir/x/w/gopath/pkg/mod/github.com/letsencrypt/pebble/v2@v2.7.0 2025/08/05 21:40:21 config file: /home/swarming/.swarming/w/ir/x/t/pebble-config-1162413246.json ... testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1934 +0x21c testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1997 +0x38 ================== pebble_test.go:799: stderr: 2025/08/05 21:40:21 http: TLS handshake error from 127.0.0.1:37998: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (15.72s) 2025/08/05 21:40:29 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/08/05 21:40:29 challHTTPServer: shutting downComment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@5defe8eb x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c0002e89f0 by goroutine 588: bytes.(*Buffer).Len() /home/swarming/.swarming/w/ir/x/w/goroot/src/bytes/buffer.go:85 +0x19c ... testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1934 +0x21c testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1997 +0x38 ================== pebble_test.go:799: stderr: 2025/08/06 01:17:51 http: TLS handshake error from 127.0.0.1:41820: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (20.58s) 2025/08/06 01:18:05 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/08/06 01:18:05 challHTTPServer: shutting downComment From: gopherbot
Change https://go.dev/cl/693596 mentions this issue: acme: fix pebble subprocess output data race
Comment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-go1.23-linux-amd64-longtest-race crypto@c247dead release-branch.go1.23@dd8b7ad9 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c0002c6780 by goroutine 577: bytes.(*Buffer).Len() /home/swarming/.swarming/w/ir/x/w/goroot/src/bytes/buffer.go:79 +0x1b0 ... testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1690 +0x226 testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1743 +0x44 ================== pebble_test.go:799: stderr: 2025/08/06 18:17:21 http: TLS handshake error from 127.0.0.1:33170: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (19.46s) 2025/08/06 18:17:35 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/08/06 18:17:35 challHTTPServer: shutting down2025-08-03 19:47 x_crypto-go1.24-linux-amd64-longtest-race crypto@c247dead release-branch.go1.24@7f36edc2 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 testing.go:1490: race detected during execution of test pebble_test.go:794: === pebble-challtestsrv output === pebble_test.go:796: stdout: pebble-challtestsrv - 2025/08/06 18:15:57 Creating TCP and UDP DNS-01 challenge server on :5565 pebble-challtestsrv - 2025/08/06 18:15:57 Answering A queries with 127.0.0.1 by default pebble-challtestsrv - 2025/08/06 18:15:57 Starting management server on :5566 ... Pebble 2025/08/06 18:16:07 POST /my-order/ -> calling handler() Pebble 2025/08/06 18:16:07 POST /finalize-order/ -> calling handler() Pebble 2025/08/06 18:16:07 Order n2lAiNutjiOmCi1PrYezXKos81xrWUkDXy1lwJuHRzI is fully authorized. Processing finalization Pebble 2025/08/06 18:16:07 POST /my-order/ -> calling handler() Pebble 2025/08/06 18:16:07 Issued certificate serial 55bf1855ac2df23e for order n2lAiNutjiOmCi1PrYezXKos81xrWUkDXy1lwJuHRzI Pebble 2025/08/06 18:16:12 POST /my-order/ -> calling handler() Pebble 2025/08/06 18:16:12 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/06 18:15:58 http: TLS handshake error from 127.0.0.1:58262: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (25.82s)2025-08-03 19:47 x_crypto-go1.25-linux-amd64-longtest-race crypto@c247dead release-branch.go1.25@ac942977 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c00029da10 by goroutine 585: bytes.(*Buffer).Len() /home/swarming/.swarming/w/ir/x/w/goroot/src/bytes/buffer.go:85 +0x19c ... testing.tRunner() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1934 +0x21c testing.(*T).Run.gowrap1() /home/swarming/.swarming/w/ir/x/w/goroot/src/testing/testing.go:1997 +0x44 ================== pebble_test.go:799: stderr: 2025/08/06 18:17:17 http: TLS handshake error from 127.0.0.1:54118: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (23.01s) 2025/08/06 18:17:30 verified 1 path(s) from issued leaf certificate to Pebble root CA 2025/08/06 18:17:30 challHTTPServer: shutting downComment From: gopherbot
Found new dashboard test flakes for:
#!watchflakes
default <- pkg == "golang.org/x/crypto/acme" && test == "TestWithPebble/TLSALPN01-Issuance"
2025-08-03 19:47 x_crypto-gotip-linux-amd64-longtest-race crypto@c247dead go@2747f925 x/crypto/acme.TestWithPebble/TLSALPN01-Issuance (log)
=== RUN TestWithPebble/TLSALPN01-Issuance === PAUSE TestWithPebble/TLSALPN01-Issuance === CONT TestWithPebble/TLSALPN01-Issuance pebble_test.go:734: fetching github.com/letsencrypt/pebble/v2@v2.7.0 pebble_test.go:794: === pebble-challtestsrv output === ================== WARNING: DATA RACE Read at 0x00c0005aa750 by goroutine 587: bytes.(*Buffer).Len() /home/swarming/.swarming/w/ir/x/w/goroot/src/bytes/buffer.go:85 +0x19c ... Pebble 2025/08/06 19:38:11 POST /my-order/ -> calling handler() Pebble 2025/08/06 19:38:11 POST /finalize-order/ -> calling handler() Pebble 2025/08/06 19:38:11 Order 0iaB27-gHp9QFXW_F4cI1LDxhxl69Sij8w7dTEfa0_4 is fully authorized. Processing finalization Pebble 2025/08/06 19:38:11 POST /my-order/ -> calling handler() Pebble 2025/08/06 19:38:11 Issued certificate serial 2eb06cc20a5fa838 for order 0iaB27-gHp9QFXW_F4cI1LDxhxl69Sij8w7dTEfa0_4 Pebble 2025/08/06 19:38:16 POST /my-order/ -> calling handler() Pebble 2025/08/06 19:38:16 POST /certZ/ -> calling handler() pebble_test.go:799: stderr: 2025/08/06 19:38:07 http: TLS handshake error from 127.0.0.1:54012: EOF --- FAIL: TestWithPebble/TLSALPN01-Issuance (20.58s)Comment From: cpu
I'm going to close this on the assumption increasing the retry count fixed the observed flake where we had enough output to diagnose the cause. After that everything was noise from the race detector flagging my earlier output collection patch and that was fixed in https://go.dev/cl/693596
Happy to dig further if there are any new failures 💥