Package: src:golang-github-henrybear327-go-proton-api
Version: 1.0.0-4
Severity: important
Tags: ftbfs trixie sid
Dear maintainer:
During a rebuild of all packages in unstable, your package failed to build:
[ please read the notes at the end ]
--------------------------------------------------------------------------------
[...]
debian/rules clean
dh clean --builddirectory=_build --buildsystem=golang
dh_auto_clean -O--builddirectory=_build -O--buildsystem=golang
dh_autoreconf_clean -O--builddirectory=_build -O--buildsystem=golang
dh_clean -O--builddirectory=_build -O--buildsystem=golang
debian/rules binary
dh binary --builddirectory=_build --buildsystem=golang
dh_update_autotools_config -O--builddirectory=_build -O--buildsystem=golang
dh_autoreconf -O--builddirectory=_build -O--buildsystem=golang
debian/rules override_dh_auto_configure
make[1]: Entering directory '/<<PKGBUILDDIR>>'
mkdir -p /<<PKGBUILDDIR>>/_build/src/google.golang.org/grpc
[... snipped ...]
google.golang.org/protobuf/internal/protolazy
google.golang.org/protobuf/internal/impl
google.golang.org/protobuf/internal/filetype
google.golang.org/protobuf/internal/version
google.golang.org/protobuf/runtime/protoimpl
google.golang.org/protobuf/protoadapt
google.golang.org/grpc/encoding/proto
google.golang.org/grpc/internal/backoff
google.golang.org/grpc/internal/balancer/gracefulswitch
google.golang.org/grpc/internal/balancerload
google.golang.org/protobuf/types/known/durationpb
github.com/golang/protobuf/ptypes/duration
google.golang.org/protobuf/types/known/timestamppb
github.com/golang/protobuf/ptypes/timestamp
google.golang.org/grpc/binarylog/grpc_binarylog_v1
google.golang.org/protobuf/types/known/anypb
google.golang.org/genproto/googleapis/rpc/status
google.golang.org/grpc/internal/status
google.golang.org/grpc/status
google.golang.org/grpc/internal/binarylog
google.golang.org/grpc/internal/buffer
google.golang.org/grpc/internal/grpcsync
google.golang.org/grpc/internal/idle
google.golang.org/grpc/internal/metadata
google.golang.org/protobuf/internal/encoding/json
google.golang.org/protobuf/encoding/protojson
google.golang.org/grpc/internal/pretty
google.golang.org/grpc/internal/serviceconfig
google.golang.org/grpc/internal/resolver
google.golang.org/grpc/internal/resolver/passthrough
google.golang.org/grpc/internal/transport/networktype
google.golang.org/grpc/internal/resolver/unix
google.golang.org/grpc/internal/syscall
google.golang.org/grpc/keepalive
google.golang.org/grpc/peer
google.golang.org/grpc/stats
google.golang.org/grpc/tap
google.golang.org/grpc/internal/transport
google.golang.org/grpc/balancer/grpclb/state
google.golang.org/grpc/internal/envconfig
google.golang.org/grpc/internal/resolver/dns/internal
google.golang.org/grpc/internal/resolver/dns
google.golang.org/grpc/resolver/dns
google.golang.org/grpc
github.com/henrybear327/go-proton-api/server/proto
dh_auto_test -O--builddirectory=_build -O--buildsystem=golang
cd _build && go test -vet=off -v -p 1
github.com/henrybear327/go-proton-api
github.com/henrybear327/go-proton-api/server
github.com/henrybear327/go-proton-api/server/backend
github.com/henrybear327/go-proton-api/server/proto
=== RUN TestFuture
--- PASS: TestFuture (0.00s)
=== RUN TestGroup
--- PASS: TestGroup (0.01s)
=== RUN TestKeyring_Unlock
time="2025-04-02T09:41:12Z" level=warning msg="Cannot unlock key" KeyID=1
error="gopenpgp: error in unlocking key: openpgp: invalid data: private key
checksum failure"
time="2025-04-02T09:41:12Z" level=warning msg="Cannot unlock key" KeyID=2
error="gopenpgp: error in unlocking key: openpgp: invalid data: private key
checksum failure"
time="2025-04-02T09:41:12Z" level=warning msg="Cannot unlock key" KeyID=3
error="gopenpgp: error in unlocking key: openpgp: invalid data: private key
checksum failure"
time="2025-04-02T09:41:12Z" level=warning msg="Cannot unlock key" KeyID=1
error="gopenpgp: error in unlocking key: openpgp: invalid data: private key
checksum failure"
time="2025-04-02T09:41:12Z" level=warning msg="Cannot unlock key" KeyID=2
error="gopenpgp: error in unlocking key: openpgp: invalid data: private key
checksum failure"
time="2025-04-02T09:41:12Z" level=warning msg="Cannot unlock key" KeyID=3
error="gopenpgp: error in unlocking key: openpgp: invalid data: private key
checksum failure"
--- PASS: TestKeyring_Unlock (0.88s)
=== RUN TestEncryptMessage_Simple
--- PASS: TestEncryptMessage_Simple (0.00s)
=== RUN TestEncryptMessage_MultipleTextParts
--- PASS: TestEncryptMessage_MultipleTextParts (0.00s)
=== RUN TestEncryptMessage_Attachment
--- PASS: TestEncryptMessage_Attachment (0.00s)
=== RUN Test_chunkSized
=== RUN Test_chunkSized/limit_by_length
=== RUN Test_chunkSized/limit_by_size
--- PASS: Test_chunkSized (0.00s)
--- PASS: Test_chunkSized/limit_by_length (0.00s)
--- PASS: Test_chunkSized/limit_by_size (0.00s)
=== RUN TestSendDraftReq_AddMIMEPackage
=== RUN TestSendDraftReq_AddMIMEPackage/Clear_MIME_with_detached_signature
=== RUN TestSendDraftReq_AddMIMEPackage/Clear_MIME_with_no_signature_(error)
=== RUN TestSendDraftReq_AddMIMEPackage/Clear_MIME_with_plain_text_(error)
=== RUN TestSendDraftReq_AddMIMEPackage/Clear_MIME_with_rich_text_(error)
=== RUN TestSendDraftReq_AddMIMEPackage/PGP_MIME_with_detached_signature
=== RUN TestSendDraftReq_AddMIMEPackage/PGP_MIME_with_plain_text_(error)
=== RUN TestSendDraftReq_AddMIMEPackage/PGP_MIME_with_rich_text_(error)
=== RUN
TestSendDraftReq_AddMIMEPackage/PGP_MIME_with_missing_public_key_(error)
=== RUN TestSendDraftReq_AddMIMEPackage/PGP_MIME_with_no_signature_(error)
--- PASS: TestSendDraftReq_AddMIMEPackage (0.29s)
--- PASS:
TestSendDraftReq_AddMIMEPackage/Clear_MIME_with_detached_signature (0.00s)
--- PASS:
TestSendDraftReq_AddMIMEPackage/Clear_MIME_with_no_signature_(error) (0.00s)
--- PASS:
TestSendDraftReq_AddMIMEPackage/Clear_MIME_with_plain_text_(error) (0.00s)
--- PASS: TestSendDraftReq_AddMIMEPackage/Clear_MIME_with_rich_text_(error)
(0.00s)
--- PASS: TestSendDraftReq_AddMIMEPackage/PGP_MIME_with_detached_signature
(0.00s)
--- PASS: TestSendDraftReq_AddMIMEPackage/PGP_MIME_with_plain_text_(error)
(0.00s)
--- PASS: TestSendDraftReq_AddMIMEPackage/PGP_MIME_with_rich_text_(error)
(0.00s)
--- PASS:
TestSendDraftReq_AddMIMEPackage/PGP_MIME_with_missing_public_key_(error) (0.00s)
--- PASS:
TestSendDraftReq_AddMIMEPackage/PGP_MIME_with_no_signature_(error) (0.00s)
=== RUN TestSendDraftReq_AddPackage
=== RUN
TestSendDraftReq_AddPackage/internal_plain_text_with_detached_signature
=== RUN TestSendDraftReq_AddPackage/internal_rich_text_with_detached_signature
=== RUN
TestSendDraftReq_AddPackage/internal_rich_text_with_bad_package_content_type_(error)
=== RUN
TestSendDraftReq_AddPackage/internal_rich_text_with_bad_recipient_content_type_(error)
=== RUN TestSendDraftReq_AddPackage/internal_with_multipart_(error)
=== RUN TestSendDraftReq_AddPackage/internal_without_encryption_(error)
=== RUN TestSendDraftReq_AddPackage/internal_without_pubkey_(error)
=== RUN TestSendDraftReq_AddPackage/internal_without_signature_(error)
=== RUN TestSendDraftReq_AddPackage/clear_rich_text_without_signature
=== RUN TestSendDraftReq_AddPackage/clear_plain_text_without_signature
=== RUN TestSendDraftReq_AddPackage/clear_plain_text_with_signature
=== RUN TestSendDraftReq_AddPackage/clear_plain_text_with_bad_scheme_(error)
=== RUN TestSendDraftReq_AddPackage/clear_rich_text_with_signature_(error)
=== RUN TestSendDraftReq_AddPackage/encrypted_plain_text_with_signature
=== RUN TestSendDraftReq_AddPackage/encrypted_html_text_with_signature_(error)
=== RUN
TestSendDraftReq_AddPackage/encrypted_mixed_text_with_signature_(error)
=== RUN TestSendDraftReq_AddPackage/encrypted_for_outside_(error)
--- PASS: TestSendDraftReq_AddPackage (0.22s)
--- PASS:
TestSendDraftReq_AddPackage/internal_plain_text_with_detached_signature (0.00s)
--- PASS:
TestSendDraftReq_AddPackage/internal_rich_text_with_detached_signature (0.00s)
--- PASS:
TestSendDraftReq_AddPackage/internal_rich_text_with_bad_package_content_type_(error)
(0.00s)
--- PASS:
TestSendDraftReq_AddPackage/internal_rich_text_with_bad_recipient_content_type_(error)
(0.00s)
--- PASS: TestSendDraftReq_AddPackage/internal_with_multipart_(error)
(0.00s)
--- PASS: TestSendDraftReq_AddPackage/internal_without_encryption_(error)
(0.00s)
--- PASS: TestSendDraftReq_AddPackage/internal_without_pubkey_(error)
(0.00s)
--- PASS: TestSendDraftReq_AddPackage/internal_without_signature_(error)
(0.00s)
--- PASS: TestSendDraftReq_AddPackage/clear_rich_text_without_signature
(0.00s)
--- PASS: TestSendDraftReq_AddPackage/clear_plain_text_without_signature
(0.00s)
--- PASS: TestSendDraftReq_AddPackage/clear_plain_text_with_signature
(0.00s)
--- PASS:
TestSendDraftReq_AddPackage/clear_plain_text_with_bad_scheme_(error) (0.00s)
--- PASS:
TestSendDraftReq_AddPackage/clear_rich_text_with_signature_(error) (0.00s)
--- PASS: TestSendDraftReq_AddPackage/encrypted_plain_text_with_signature
(0.00s)
--- PASS:
TestSendDraftReq_AddPackage/encrypted_html_text_with_signature_(error) (0.00s)
--- PASS:
TestSendDraftReq_AddPackage/encrypted_mixed_text_with_signature_(error) (0.00s)
--- PASS: TestSendDraftReq_AddPackage/encrypted_for_outside_(error) (0.00s)
=== RUN TestDecrypt
message_types_test.go:12: Skipping, expired GPG key
--- SKIP: TestDecrypt (0.00s)
=== RUN TestPool_NewJob
panic: test timed out after 10m0s
running tests:
TestPool_NewJob (9m59s)
goroutine 63 [running]:
testing.(*M).startAlarm.func1()
/usr/lib/go-1.24/src/testing/testing.go:2484 +0x394
created by time.goFunc
/usr/lib/go-1.24/src/time/sleep.go:215 +0x2d
goroutine 1 [chan receive, 9 minutes]:
testing.(*T).Run(0xc000178700, {0xd57849?, 0xc000277a30?}, 0xda6d88)
/usr/lib/go-1.24/src/testing/testing.go:1859 +0x431
testing.runTests.func1(0xc000178700)
/usr/lib/go-1.24/src/testing/testing.go:2279 +0x37
testing.tRunner(0xc000178700, 0xc000277b70)
/usr/lib/go-1.24/src/testing/testing.go:1792 +0xf4
testing.runTests(0xc000383398, {0x13cbbe0, 0x39, 0x39}, {0x7f9cdc57f800?,
0x4493e0?, 0x14db480?})
/usr/lib/go-1.24/src/testing/testing.go:2277 +0x4b4
testing.(*M).Run(0xc000213cc0)
/usr/lib/go-1.24/src/testing/testing.go:2142 +0x64a
go.uber.org/goleak.VerifyTestMain({0xe91140?, 0xc000213cc0?}, {0xc00043de90,
0x1, 0x1})
/<<PKGBUILDDIR>>/_build/src/go.uber.org/goleak/testmain.go:53 +0x5a
github.com/henrybear327/go-proton-api.TestMain(0xc000213cc0)
/<<PKGBUILDDIR>>/_build/src/github.com/henrybear327/go-proton-api/main_test.go:10
+0x45
main.main()
_testmain.go:161 +0xa8
goroutine 60 [chan receive, 9 minutes]:
github.com/henrybear327/go-proton-api.(*job[...]).result(...)
/<<PKGBUILDDIR>>/_build/src/github.com/henrybear327/go-proton-api/job.go:26
github.com/henrybear327/go-proton-api.TestPool_NewJob(0xc000488a80)
/<<PKGBUILDDIR>>/_build/src/github.com/henrybear327/go-proton-api/pool_test.go:28
+0x196
testing.tRunner(0xc000488a80, 0xda6d88)
/usr/lib/go-1.24/src/testing/testing.go:1792 +0xf4
created by testing.(*T).Run in goroutine 1
/usr/lib/go-1.24/src/testing/testing.go:1851 +0x413
goroutine 61 [select, 9 minutes]:
github.com/ProtonMail/gluon/async.NewQueuedChannel[...].func1()
/<<PKGBUILDDIR>>/_build/src/github.com/ProtonMail/gluon/async/queued_channel.go:40
+0xde
runtime/pprof.Do({0xe99c58?, 0x14fd640?}, {{0xc00007f9e0?, 0x0?, 0x0?}},
0xc000431758)
/usr/lib/go-1.24/src/runtime/pprof/runtime.go:51 +0x8c
github.com/ProtonMail/gluon/logging.pprofDo(...)
/<<PKGBUILDDIR>>/_build/src/github.com/ProtonMail/gluon/logging/pprof_default.go:11
github.com/ProtonMail/gluon/logging.DoAnnotated({0xe99c58, 0x14fd640},
0xc000431758, {0x0?, 0x0?, 0x0?})
/<<PKGBUILDDIR>>/_build/src/github.com/ProtonMail/gluon/logging/logging.go:24
+0x4d
github.com/ProtonMail/gluon/async.GoAnnotated.func1()
/<<PKGBUILDDIR>>/_build/src/github.com/ProtonMail/gluon/async/logging.go:12
+0x68
created by github.com/ProtonMail/gluon/async.GoAnnotated in goroutine 60
/<<PKGBUILDDIR>>/_build/src/github.com/ProtonMail/gluon/async/logging.go:10
+0xd0
goroutine 62 [chan send, 9 minutes]:
github.com/henrybear327/go-proton-api.(*job[...]).postSuccess(...)
/<<PKGBUILDDIR>>/_build/src/github.com/henrybear327/go-proton-api/job.go:31
github.com/henrybear327/go-proton-api.NewPool[...].func1()
/<<PKGBUILDDIR>>/_build/src/github.com/henrybear327/go-proton-api/pool.go:49
+0x218
created by github.com/henrybear327/go-proton-api.NewPool[...] in goroutine 60
/<<PKGBUILDDIR>>/_build/src/github.com/henrybear327/go-proton-api/pool.go:34
+0x8d
FAIL github.com/henrybear327/go-proton-api 600.119s
=== RUN TestServer_Quark_CreateUser
--- PASS: TestServer_Quark_CreateUser (1.03s)
=== RUN TestServer_Quark_CreateAddress
--- PASS: TestServer_Quark_CreateAddress (0.44s)
=== RUN TestServer_LoginLogout
2025/04/02 09:51:15.612676 WARN RESTY 401 DELETE
https://127.0.0.1:42201/auth/v4: 401 Unauthorized (Code=0, Status=401), Attempt
1
2025/04/02 09:51:15.612892 ERROR RESTY 401 DELETE
https://127.0.0.1:42201/auth/v4: 401 Unauthorized (Code=0, Status=401)
2025/04/02 09:51:15.613110 WARN RESTY 422 POST
https://127.0.0.1:42201/auth/v4/refresh: 422 Unprocessable Entity (Code=0,
Status=422), Attempt 1
2025/04/02 09:51:15.613180 ERROR RESTY 422 POST
https://127.0.0.1:42201/auth/v4/refresh: 422 Unprocessable Entity (Code=0,
Status=422)
--- PASS: TestServer_LoginLogout (0.37s)
=== RUN TestServerMulti
2025/04/02 09:51:16.145028 WARN RESTY 401 GET
https://127.0.0.1:35401/core/v4/users: 401 Unauthorized (Code=0, Status=401),
Attempt 1
2025/04/02 09:51:16.145254 ERROR RESTY 401 GET
https://127.0.0.1:35401/core/v4/users: 401 Unauthorized (Code=0, Status=401)
2025/04/02 09:51:16.145442 WARN RESTY 422 POST
https://127.0.0.1:35401/auth/v4/refresh: 422 Unprocessable Entity (Code=0,
Status=422), Attempt 1
2025/04/02 09:51:16.145506 ERROR RESTY 422 POST
https://127.0.0.1:35401/auth/v4/refresh: 422 Unprocessable Entity (Code=0,
Status=422)
--- PASS: TestServerMulti (0.53s)
=== RUN TestServer_Ping
2025/04/02 09:51:16.146447 WARN RESTY Get "https://127.0.0.1:45467/tests/ping":
dial failed (not allowed), Attempt 1
2025/04/02 09:51:16.246778 WARN RESTY Get "https://127.0.0.1:45467/tests/ping":
dial failed (not allowed), Attempt 2
2025/04/02 09:51:16.428126 WARN RESTY Get "https://127.0.0.1:45467/tests/ping":
dial failed (not allowed), Attempt 3
2025/04/02 09:51:16.727583 WARN RESTY Get "https://127.0.0.1:45467/tests/ping":
dial failed (not allowed), Attempt 4
2025/04/02 09:51:16.727604 ERROR RESTY Get
"https://127.0.0.1:45467/tests/ping": dial failed (not allowed)
2025/04/02 09:51:16.729427 WARN RESTY 503 GET
https://127.0.0.1:45467/tests/ping: 503 Service Unavailable (Code=0,
Status=503), Attempt 1
time="2025-04-02T09:51:16Z" level=warning msg="Too many requests, retrying
after delay" after=10 method=GET pkg=go-proton-api status=503
url="https://127.0.0.1:45467/tests/ping";
2025/04/02 09:51:26.738714 WARN RESTY 503 GET
https://127.0.0.1:45467/tests/ping: 503 Service Unavailable (Code=0,
Status=503), Attempt 2
time="2025-04-02T09:51:26Z" level=warning msg="Too many requests, retrying
after delay" after=17 method=GET pkg=go-proton-api status=503
url="https://127.0.0.1:45467/tests/ping";
2025/04/02 09:51:43.739088 WARN RESTY 503 GET
https://127.0.0.1:45467/tests/ping: 503 Service Unavailable (Code=0,
Status=503), Attempt 3
time="2025-04-02T09:51:43Z" level=warning msg="Too many requests, retrying
after delay" after=11 method=GET pkg=go-proton-api status=503
url="https://127.0.0.1:45467/tests/ping";
2025/04/02 09:51:54.739435 WARN RESTY 503 GET
https://127.0.0.1:45467/tests/ping: 503 Service Unavailable (Code=0,
Status=503), Attempt 4
2025/04/02 09:51:54.739447 ERROR RESTY 503 GET
https://127.0.0.1:45467/tests/ping: 503 Service Unavailable (Code=0, Status=503)
2025/04/02 09:51:54.739522 WARN RESTY Get "https://127.0.0.1:45467/tests/ping":
dial failed (not allowed), Attempt 1
2025/04/02 09:51:54.839814 WARN RESTY Get "https://127.0.0.1:45467/tests/ping":
dial failed (not allowed), Attempt 2
2025/04/02 09:51:54.996056 WARN RESTY Get "https://127.0.0.1:45467/tests/ping":
dial failed (not allowed), Attempt 3
2025/04/02 09:51:55.377643 WARN RESTY Get "https://127.0.0.1:45467/tests/ping":
dial failed (not allowed), Attempt 4
2025/04/02 09:51:55.377664 ERROR RESTY Get
"https://127.0.0.1:45467/tests/ping": dial failed (not allowed)
2025/04/02 09:51:55.379370 WARN RESTY 503 GET
https://127.0.0.1:45467/tests/ping: 503 Service Unavailable (Code=0,
Status=503), Attempt 1
time="2025-04-02T09:51:55Z" level=warning msg="Too many requests, retrying
after delay" after=11 method=GET pkg=go-proton-api status=503
url="https://127.0.0.1:45467/tests/ping";
2025/04/02 09:52:06.386245 WARN RESTY 503 GET
https://127.0.0.1:45467/tests/ping: 503 Service Unavailable (Code=0,
Status=503), Attempt 2
time="2025-04-02T09:52:06Z" level=warning msg="Too many requests, retrying
after delay" after=17 method=GET pkg=go-proton-api status=503
url="https://127.0.0.1:45467/tests/ping";
2025/04/02 09:52:23.386612 WARN RESTY 503 GET
https://127.0.0.1:45467/tests/ping: 503 Service Unavailable (Code=0,
Status=503), Attempt 3
time="2025-04-02T09:52:23Z" level=warning msg="Too many requests, retrying
after delay" after=17 method=GET pkg=go-proton-api status=503
url="https://127.0.0.1:45467/tests/ping";
2025/04/02 09:52:40.386982 WARN RESTY 503 GET
https://127.0.0.1:45467/tests/ping: 503 Service Unavailable (Code=0,
Status=503), Attempt 4
2025/04/02 09:52:40.386994 ERROR RESTY 503 GET
https://127.0.0.1:45467/tests/ping: 503 Service Unavailable (Code=0, Status=503)
--- PASS: TestServer_Ping (84.24s)
=== RUN TestServer_Bool
--- PASS: TestServer_Bool (0.43s)
=== RUN TestServer_Messages
--- PASS: TestServer_Messages (0.50s)
=== RUN TestServer_GetMessageMetadataPage
--- PASS: TestServer_GetMessageMetadataPage (0.51s)
=== RUN TestServer_MessageFilter
--- PASS: TestServer_MessageFilter (0.51s)
=== RUN TestServer_MessageFilterDesc
--- PASS: TestServer_MessageFilterDesc (0.44s)
=== RUN TestServer_MessageIDs
--- PASS: TestServer_MessageIDs (1.01s)
=== RUN TestServer_MessagesDelete
--- PASS: TestServer_MessagesDelete (0.52s)
=== RUN TestServer_MessagesDeleteAfterUpdate
--- PASS: TestServer_MessagesDeleteAfterUpdate (0.51s)
=== RUN TestServer_Events
--- PASS: TestServer_Events (3.43s)
=== RUN TestServer_Events_Multi
--- PASS: TestServer_Events_Multi (3.65s)
=== RUN TestServer_Events_Refresh
--- PASS: TestServer_Events_Refresh (1.37s)
=== RUN TestServer_Events_UserSettings
--- PASS: TestServer_Events_UserSettings (1.37s)
=== RUN TestServer_RevokeUser
2025/04/02 09:52:54.995024 WARN RESTY 401 DELETE
https://127.0.0.1:44347/auth/v4: 401 Unauthorized (Code=0, Status=401), Attempt
1
2025/04/02 09:52:54.995252 ERROR RESTY 401 DELETE
https://127.0.0.1:44347/auth/v4: 401 Unauthorized (Code=0, Status=401)
2025/04/02 09:52:54.995438 WARN RESTY 422 POST
https://127.0.0.1:44347/auth/v4/refresh: 422 Unprocessable Entity (Code=0,
Status=422), Attempt 1
2025/04/02 09:52:54.995503 ERROR RESTY 422 POST
https://127.0.0.1:44347/auth/v4/refresh: 422 Unprocessable Entity (Code=0,
Status=422)
--- PASS: TestServer_RevokeUser (0.37s)
=== RUN TestServer_Calls
--- PASS: TestServer_Calls (0.37s)
=== RUN TestServer_Calls_Status
2025/04/02 09:52:55.730135 WARN RESTY 422 GET
https://127.0.0.1:46629/mail/v4/messages/no%20such%20message%20ID: Message no
such message ID not found (Code=2001, Status=422), Attempt 1
2025/04/02 09:52:55.730359 ERROR RESTY 422 GET
https://127.0.0.1:46629/mail/v4/messages/no%20such%20message%20ID: Message no
such message ID not found (Code=2001, Status=422)
--- PASS: TestServer_Calls_Status (0.37s)
=== RUN TestServer_Calls_Request
--- PASS: TestServer_Calls_Request (0.36s)
=== RUN TestServer_Calls_Response
--- PASS: TestServer_Calls_Response (0.37s)
=== RUN TestServer_Calls_Cookies
--- PASS: TestServer_Calls_Cookies (0.37s)
=== RUN TestServer_Calls_Manager
--- PASS: TestServer_Calls_Manager (0.00s)
=== RUN TestServer_CreateMessage
--- PASS: TestServer_CreateMessage (0.43s)
=== RUN TestServer_UpdateDraft
--- PASS: TestServer_UpdateDraft (1.44s)
=== RUN TestServer_SendMessage
--- PASS: TestServer_SendMessage (0.43s)
=== RUN TestServer_AuthDelete
--- PASS: TestServer_AuthDelete (0.37s)
=== RUN TestServer_ForceUpgrade
2025/04/02 09:52:59.695479 WARN RESTY 400 POST
https://127.0.0.1:43655/auth/v4/info: This version of the app is no longer
supported, please update to continue using the app (Code=5003, Status=400),
Attempt 1
2025/04/02 09:52:59.695676 ERROR RESTY 400 POST
https://127.0.0.1:43655/auth/v4/info: This version of the app is no longer
supported, please update to continue using the app (Code=5003, Status=400)
--- PASS: TestServer_ForceUpgrade (0.20s)
=== RUN TestServer_Import
--- PASS: TestServer_Import (0.43s)
=== RUN TestServer_Import_Dedup
--- PASS: TestServer_Import_Dedup (0.43s)
=== RUN TestServer_Labels
=== RUN TestServer_Labels/received_flag,_no_actions
=== RUN TestServer_Labels/sent_flag,_no_actions
=== RUN TestServer_Labels/scheduled_flag,_no_actions
=== RUN TestServer_Labels/received_flag,_add_inbox
=== RUN TestServer_Labels/sent_flag,_add_sent
=== RUN TestServer_Labels/scheduled_flag,_add_scheduled
=== RUN TestServer_Labels/received_flag,_add_inbox_then_add_archive
=== RUN TestServer_Labels/sent_flag,_add_sent_then_add_archive
=== RUN TestServer_Labels/scheduled_flag,_add_scheduled_then_add_archive
=== RUN TestServer_Labels/received_flag,_add_inbox_then_remove_inbox
=== RUN TestServer_Labels/sent_flag,_add_sent_then_remove_sent
=== RUN TestServer_Labels/scheduled_flag,_add_scheduled_then_remove_scheduled
=== RUN TestServer_Labels/received_flag,_add_inbox_then_remove_archive
=== RUN TestServer_Labels/sent_flag,_add_sent_then_remove_archive
=== RUN TestServer_Labels/scheduled_flag,_add_scheduled_then_remove_archive
=== RUN
TestServer_Labels/received_flag,_add_inbox_then_remove_inbox_then_add_archive
=== RUN
TestServer_Labels/sent_flag,_add_sent_then_remove_sent_then_add_archive
=== RUN
TestServer_Labels/scheduled_flag,_add_scheduled_then_remove_scheduled_then_add_archive
=== RUN TestServer_Labels/received_flag,_add_starred
=== RUN TestServer_Labels/sent_flag,_add_starred
=== RUN TestServer_Labels/scheduled_flag,_add_starred
=== RUN TestServer_Labels/received_flag,_add_inbox,_add_starred,_remove_inbox
=== RUN TestServer_Labels/sent_flag,_add_sent,_add_starred,_remove_sent
=== RUN
TestServer_Labels/scheduled_flag,_add_scheduled,_add_starred,_remove_scheduled
=== RUN TestServer_Labels/received_flag,_add_trash,_remove_trash
=== RUN TestServer_Labels/sent_flag,_add_trash,_remove_trash
=== RUN TestServer_Labels/scheduled_flag,_add_trash,_remove_trash
=== RUN TestServer_Labels/received_flag,_add_inbox,_add_trash,_remove_inbox
=== RUN TestServer_Labels/scheduled_&_sent_flags,_add_scheduled,_add_sent
--- PASS: TestServer_Labels (0.46s)
--- PASS: TestServer_Labels/received_flag,_no_actions (0.00s)
--- PASS: TestServer_Labels/sent_flag,_no_actions (0.00s)
--- PASS: TestServer_Labels/scheduled_flag,_no_actions (0.00s)
--- PASS: TestServer_Labels/received_flag,_add_inbox (0.00s)
--- PASS: TestServer_Labels/sent_flag,_add_sent (0.00s)
--- PASS: TestServer_Labels/scheduled_flag,_add_scheduled (0.00s)
--- PASS: TestServer_Labels/received_flag,_add_inbox_then_add_archive
(0.00s)
--- PASS: TestServer_Labels/sent_flag,_add_sent_then_add_archive (0.00s)
--- PASS: TestServer_Labels/scheduled_flag,_add_scheduled_then_add_archive
(0.00s)
--- PASS: TestServer_Labels/received_flag,_add_inbox_then_remove_inbox
(0.00s)
--- PASS: TestServer_Labels/sent_flag,_add_sent_then_remove_sent (0.00s)
--- PASS:
TestServer_Labels/scheduled_flag,_add_scheduled_then_remove_scheduled (0.00s)
--- PASS: TestServer_Labels/received_flag,_add_inbox_then_remove_archive
(0.00s)
--- PASS: TestServer_Labels/sent_flag,_add_sent_then_remove_archive (0.00s)
--- PASS:
TestServer_Labels/scheduled_flag,_add_scheduled_then_remove_archive (0.00s)
--- PASS:
TestServer_Labels/received_flag,_add_inbox_then_remove_inbox_then_add_archive
(0.00s)
--- PASS:
TestServer_Labels/sent_flag,_add_sent_then_remove_sent_then_add_archive (0.00s)
--- PASS:
TestServer_Labels/scheduled_flag,_add_scheduled_then_remove_scheduled_then_add_archive
(0.00s)
--- PASS: TestServer_Labels/received_flag,_add_starred (0.00s)
--- PASS: TestServer_Labels/sent_flag,_add_starred (0.00s)
--- PASS: TestServer_Labels/scheduled_flag,_add_starred (0.00s)
--- PASS:
TestServer_Labels/received_flag,_add_inbox,_add_starred,_remove_inbox (0.00s)
--- PASS: TestServer_Labels/sent_flag,_add_sent,_add_starred,_remove_sent
(0.00s)
--- PASS:
TestServer_Labels/scheduled_flag,_add_scheduled,_add_starred,_remove_scheduled
(0.00s)
--- PASS: TestServer_Labels/received_flag,_add_trash,_remove_trash (0.00s)
--- PASS: TestServer_Labels/sent_flag,_add_trash,_remove_trash (0.00s)
--- PASS: TestServer_Labels/scheduled_flag,_add_trash,_remove_trash (0.00s)
--- PASS:
TestServer_Labels/received_flag,_add_inbox,_add_trash,_remove_inbox (0.00s)
--- PASS: TestServer_Labels/scheduled_&_sent_flags,_add_scheduled,_add_sent
(0.00s)
=== RUN TestServer_Import_FlagsAndLabels
=== RUN TestServer_Import_FlagsAndLabels/received_flag_-->_no_label
=== RUN TestServer_Import_FlagsAndLabels/received_flag_-->_inbox
=== RUN TestServer_Import_FlagsAndLabels/sent_flag_-->_sent
=== RUN TestServer_Import_FlagsAndLabels/received_flag_-->_sent
=== RUN TestServer_Import_FlagsAndLabels/sent_flag_-->_inbox
=== RUN TestServer_Import_FlagsAndLabels/no_flag_-->_drafts
=== RUN TestServer_Import_FlagsAndLabels/forbidden:_received_flag_-->_All_Mail
=== RUN TestServer_Import_FlagsAndLabels/forbidden:_sent_flag_-->_All_Mail
=== RUN
TestServer_Import_FlagsAndLabels/forbidden:_received_flag_-->_inbox_and_all_mail
=== RUN
TestServer_Import_FlagsAndLabels/forbidden:_sent_flag_-->_sent_and_all_mail
=== RUN
TestServer_Import_FlagsAndLabels/forbidden:_received_flag_-->_inbox_and_sent
=== RUN
TestServer_Import_FlagsAndLabels/forbidden:_sent_flag_-->_inbox_and_sent
=== RUN
TestServer_Import_FlagsAndLabels/forbidden:_received_flag_-->_inbox_and_archive
--- PASS: TestServer_Import_FlagsAndLabels (0.44s)
--- PASS: TestServer_Import_FlagsAndLabels/received_flag_-->_no_label
(0.00s)
--- PASS: TestServer_Import_FlagsAndLabels/received_flag_-->_inbox (0.00s)
--- PASS: TestServer_Import_FlagsAndLabels/sent_flag_-->_sent (0.00s)
--- PASS: TestServer_Import_FlagsAndLabels/received_flag_-->_sent (0.00s)
--- PASS: TestServer_Import_FlagsAndLabels/sent_flag_-->_inbox (0.00s)
--- PASS: TestServer_Import_FlagsAndLabels/no_flag_-->_drafts (0.00s)
--- PASS:
TestServer_Import_FlagsAndLabels/forbidden:_received_flag_-->_All_Mail (0.00s)
--- PASS:
TestServer_Import_FlagsAndLabels/forbidden:_sent_flag_-->_All_Mail (0.00s)
--- PASS:
TestServer_Import_FlagsAndLabels/forbidden:_received_flag_-->_inbox_and_all_mail
(0.00s)
--- PASS:
TestServer_Import_FlagsAndLabels/forbidden:_sent_flag_-->_sent_and_all_mail
(0.00s)
--- PASS:
TestServer_Import_FlagsAndLabels/forbidden:_received_flag_-->_inbox_and_sent
(0.00s)
--- PASS:
TestServer_Import_FlagsAndLabels/forbidden:_sent_flag_-->_inbox_and_sent (0.00s)
--- PASS:
TestServer_Import_FlagsAndLabels/forbidden:_received_flag_-->_inbox_and_archive
(0.00s)
=== RUN TestServer_PublicKeys
--- PASS: TestServer_PublicKeys (0.57s)
=== RUN TestServer_Proxy
--- PASS: TestServer_Proxy (0.53s)
=== RUN TestServer_Proxy_Cache
--- PASS: TestServer_Proxy_Cache (0.81s)
=== RUN TestServer_Proxy_AuthDelete
--- PASS: TestServer_Proxy_AuthDelete (0.54s)
=== RUN TestServer_RealProxy
server_test.go:1484: skipping test, set the username and password to run
--- SKIP: TestServer_RealProxy (0.00s)
=== RUN TestServer_RealProxy_Cache
server_test.go:1515: skipping test, set the username and password to run
--- SKIP: TestServer_RealProxy_Cache (0.00s)
=== RUN TestServer_Messages_Fetch
2025/04/02 09:53:04.700245 WARN RESTY read failed (limit reached), Attempt 1
2025/04/02 09:53:04.700469 ERROR RESTY read failed (limit reached)
--- PASS: TestServer_Messages_Fetch (0.90s)
=== RUN TestServer_Status
2025/04/02 09:53:05.330224 WARN RESTY Get
"http://127.0.0.1:36139/core/v4/users": read failed (not allowed), Attempt 1
2025/04/02 09:53:05.430938 WARN RESTY Get
"http://127.0.0.1:36139/core/v4/users": read failed (not allowed), Attempt 2
2025/04/02 09:53:05.615707 WARN RESTY Get
"http://127.0.0.1:36139/core/v4/users": read failed (not allowed), Attempt 3
2025/04/02 09:53:05.868457 WARN RESTY Get
"http://127.0.0.1:36139/core/v4/users": read failed (not allowed), Attempt 4
2025/04/02 09:53:05.868474 ERROR RESTY Get
"http://127.0.0.1:36139/core/v4/users": read failed (not allowed)
--- PASS: TestServer_Status (1.07s)
=== RUN TestServer_Labels_Duplicates
2025/04/02 09:53:06.234040 WARN RESTY 409 POST
https://127.0.0.1:46685/core/v4/labels: 409 Conflict (Code=0, Status=409),
Attempt 1
2025/04/02 09:53:06.234251 ERROR RESTY 409 POST
https://127.0.0.1:46685/core/v4/labels: 409 Conflict (Code=0, Status=409)
--- PASS: TestServer_Labels_Duplicates (0.37s)
=== RUN TestServer_Labels_Duplicates_Update
2025/04/02 09:53:06.599449 WARN RESTY 409 PUT
https://127.0.0.1:44119/core/v4/labels/82b42609-4bee-420d-a938-8938b493e900:
409 Conflict (Code=0, Status=409), Attempt 1
2025/04/02 09:53:06.599659 ERROR RESTY 409 PUT
https://127.0.0.1:44119/core/v4/labels/82b42609-4bee-420d-a938-8938b493e900:
409 Conflict (Code=0, Status=409)
--- PASS: TestServer_Labels_Duplicates_Update (0.37s)
=== RUN TestServer_Labels_Subfolders
--- PASS: TestServer_Labels_Subfolders (0.37s)
=== RUN TestServer_Labels_Subfolders_Reassign
--- PASS: TestServer_Labels_Subfolders_Reassign (0.37s)
=== RUN TestServer_Labels_Subfolders_DeleteParentWithChildren
--- PASS: TestServer_Labels_Subfolders_DeleteParentWithChildren (0.37s)
=== RUN TestServer_AddressCreateDelete
--- PASS: TestServer_AddressCreateDelete (0.43s)
=== RUN TestServer_AddressOrder
--- PASS: TestServer_AddressOrder (0.56s)
=== RUN TestServer_MailSettings
--- PASS: TestServer_MailSettings (0.37s)
=== RUN TestServer_UserSettings
2025/04/02 09:53:09.432784 WARN RESTY 500 PUT
https://127.0.0.1:45497/core/v4/settings/telemetry: 500 Internal Server Error
(Code=0, Status=500), Attempt 1
2025/04/02 09:53:09.433004 ERROR RESTY 500 PUT
https://127.0.0.1:45497/core/v4/settings/telemetry: 500 Internal Server Error
(Code=0, Status=500)
2025/04/02 09:53:09.433363 WARN RESTY 500 PUT
https://127.0.0.1:45497/core/v4/settings/crashreports: 500 Internal Server
Error (Code=0, Status=500), Attempt 1
2025/04/02 09:53:09.433430 ERROR RESTY 500 PUT
https://127.0.0.1:45497/core/v4/settings/crashreports: 500 Internal Server
Error (Code=0, Status=500)
--- PASS: TestServer_UserSettings (0.37s)
=== RUN TestServer_Domains
--- PASS: TestServer_Domains (0.00s)
=== RUN TestServer_StatusHooks
2025/04/02 09:53:09.800899 WARN RESTY 400 GET
https://127.0.0.1:44527/core/v4/addresses: Request failed with status 400
(Code=2001, Status=400), Attempt 1
2025/04/02 09:53:09.801123 ERROR RESTY 400 GET
https://127.0.0.1:44527/core/v4/addresses: Request failed with status 400
(Code=2001, Status=400)
--- PASS: TestServer_StatusHooks (0.36s)
=== RUN TestServer_SendDataEvent
2025/04/02 09:53:10.169759 WARN RESTY 400 POST
https://127.0.0.1:36307/data/v1/stats: 400 Bad Request (Code=0, Status=400),
Attempt 1
2025/04/02 09:53:10.169987 ERROR RESTY 400 POST
https://127.0.0.1:36307/data/v1/stats: 400 Bad Request (Code=0, Status=400)
--- PASS: TestServer_SendDataEvent (0.37s)
=== RUN TestServer_SendDataEventMultiple
2025/04/02 09:53:10.536193 WARN RESTY 400 POST
https://127.0.0.1:45571/data/v1/stats/multiple: 400 Bad Request (Code=0,
Status=400), Attempt 1
2025/04/02 09:53:10.536421 ERROR RESTY 400 POST
https://127.0.0.1:45571/data/v1/stats/multiple: 400 Bad Request (Code=0,
Status=400)
--- PASS: TestServer_SendDataEventMultiple (0.37s)
=== RUN TestServer_GetMessageGroupCount
--- PASS: TestServer_GetMessageGroupCount (0.44s)
PASS
ok github.com/henrybear327/go-proton-api/server 117.245s
=== RUN TestID
--- PASS: TestID (0.00s)
=== RUN Test_mergeUpdates
=== RUN Test_mergeUpdates/single
=== RUN Test_mergeUpdates/multiple
=== RUN Test_mergeUpdates/replace_with_updated
=== RUN Test_mergeUpdates/replace_with_delete
--- PASS: Test_mergeUpdates (0.00s)
--- PASS: Test_mergeUpdates/single (0.00s)
--- PASS: Test_mergeUpdates/multiple (0.00s)
--- PASS: Test_mergeUpdates/replace_with_updated (0.00s)
--- PASS: Test_mergeUpdates/replace_with_delete (0.00s)
PASS
ok github.com/henrybear327/go-proton-api/server/backend 0.056s
? github.com/henrybear327/go-proton-api/server/proto [no test files]
FAIL
dh_auto_test: error: cd _build && go test -vet=off -v -p 1
github.com/henrybear327/go-proton-api
github.com/henrybear327/go-proton-api/server
github.com/henrybear327/go-proton-api/server/backend
github.com/henrybear327/go-proton-api/server/proto returned exit code 1
make: *** [debian/rules:14: binary] Error 25
dpkg-buildpackage: error: debian/rules binary subprocess returned exit status 2
--------------------------------------------------------------------------------
The above is just how the build ends and not necessarily the most relevant part.
If required, the full build log is available here:
https://people.debian.org/~sanvila/build-logs/202503/
About the archive rebuild: The build was made on virtual machines from AWS,
using sbuild and a reduced chroot with only build-essential packages.
In this particular case, the build was made on AWS machines of type
m7a.medium and r7a.medium. Incidentally, those machines have a single CPU,
but at this point it's not clear yet if that's the condition which triggers
the build failure or, for example, the fact that they are overall slower
than other instance types, or maybe some other reason.
If you could not reproduce the bug using GRUB_CMDLINE_LINUX="nr_cpus=1"
please contact me privately, as I am willing to provide ssh access to a
virtual machine where the bug is fully reproducible.
Disclaimer: Please note that this is probably a violation of
Debian Policy 4.2, and the only reason I'm initially reporting
it as "important" is to avoid discussing about the severity.
If this is really a bug in one of the build-depends, please use
reassign and add an affects on src:golang-github-henrybear327-go-proton-api, so
that this is still
visible in the BTS web page for this package.
Thanks.
