Diff of the two buildlogs: -- --- b1/build.log 2024-05-09 06:43:59.082593212 +0000 +++ b2/build.log 2024-05-09 06:46:22.272497332 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed May 8 18:40:46 -12 2024 -I: pbuilder-time-stamp: 1715236846 +I: Current time: Thu Jun 12 03:07:02 +14 2025 +I: pbuilder-time-stamp: 1749647222 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/unstable-reproducible-base.tgz] I: copying local configuration @@ -27,51 +27,83 @@ dpkg-source: info: applying 0001-Use_chasquid_user.patch I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/1187562/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/1856390/tmp/hooks/D01_modify_environment starting +debug: Running on infom02-amd64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Jun 11 13:07 /bin/sh -> /bin/bash +I: Setting pbuilder2's login shell to /bin/bash +I: Setting pbuilder2's GECOS to second user,second room,second work-phone,second home-phone,second other +I: user script /srv/workspace/pbuilder/1856390/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/1856390/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='amd64' - DEBIAN_FRONTEND='noninteractive' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="21" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu") + BASH_VERSION='5.2.21(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=amd64 + DEBIAN_FRONTEND=noninteractive DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=12 ' - DISTRIBUTION='unstable' - HOME='/root' - HOST_ARCH='amd64' + DIRSTACK=() + DISTRIBUTION=unstable + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=x86_64 + HOST_ARCH=amd64 IFS=' ' - INVOCATION_ID='e365cd23404e48a8a459e0ee5f4cb437' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='1187562' - PS1='# ' - PS2='> ' + INVOCATION_ID=695365892a544bf28eb201d269b41d68 + LANG=C + LANGUAGE=et_EE:et + LC_ALL=C + MACHTYPE=x86_64-pc-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=1856390 PS4='+ ' - PWD='/' - SHELL='/bin/bash' - SHLVL='2' - SUDO_COMMAND='/usr/bin/timeout -k 18.1h 18h /usr/bin/ionice -c 3 /usr/bin/nice /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.ekk23Ij8/pbuilderrc_ED6W --distribution unstable --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.ekk23Ij8/b1 --logfile b1/build.log chasquid_1.13-1.dsc' - SUDO_GID='109' - SUDO_UID='104' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.ekk23Ij8/pbuilderrc_MUpu --distribution unstable --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.ekk23Ij8/b2 --logfile b2/build.log chasquid_1.13-1.dsc' + SUDO_GID=109 + SUDO_UID=104 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' I: uname -a - Linux infom01-amd64 6.1.0-21-cloud-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.90-1 (2024-05-03) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.6.13+bpo-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.6.13-1~bpo12+1 (2024-02-15) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 May 8 07:42 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/1187562/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Jun 10 14:05 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/1856390/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -175,7 +207,7 @@ Get: 44 http://deb.debian.org/debian unstable/main amd64 golang-blitiri-go-log-dev all 1.1.0-1 [6724 B] Get: 45 http://deb.debian.org/debian unstable/main amd64 golang-blitiri-go-spf-dev all 1.5.1-1 [37.2 kB] Get: 46 http://deb.debian.org/debian unstable/main amd64 golang-blitiri-go-systemd-dev all 1.1.0-1 [6952 B] -Fetched 70.5 MB in 1s (71.1 MB/s) +Fetched 70.5 MB in 1s (100 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package sensible-utils. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 19699 files and directories currently installed.) @@ -374,7 +406,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/chasquid-1.13/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-genchanges -S > ../chasquid_1.13-1_source.changes +I: user script /srv/workspace/pbuilder/1856390/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for unstable +I: user script /srv/workspace/pbuilder/1856390/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/chasquid-1.13/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-genchanges -S > ../chasquid_1.13-1_source.changes dpkg-buildpackage: info: source package chasquid dpkg-buildpackage: info: source version 1.13-1 dpkg-buildpackage: info: source distribution unstable @@ -395,27 +431,27 @@ make[1]: Entering directory '/build/reproducible-path/chasquid-1.13' dh_auto_build -- -ldflags " -X main.version=1.13-1 -X main.sourceDateTs=1703600557" cd obj-x86_64-linux-gnu && go install -trimpath -v -p 12 -ldflags " -X main.version=1.13-1 -X main.sourceDateTs=1703600557" blitiri.com.ar/go/chasquid blitiri.com.ar/go/chasquid/cmd/chasquid-util blitiri.com.ar/go/chasquid/cmd/mda-lmtp blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/aliases blitiri.com.ar/go/chasquid/internal/auth blitiri.com.ar/go/chasquid/internal/config blitiri.com.ar/go/chasquid/internal/courier blitiri.com.ar/go/chasquid/internal/domaininfo blitiri.com.ar/go/chasquid/internal/dovecot blitiri.com.ar/go/chasquid/internal/envelope blitiri.com.ar/go/chasquid/internal/expvarom blitiri.com.ar/go/chasquid/internal/haproxy blitiri.com.ar/go/chasquid/internal/localrpc blitiri.com.ar/go/chasquid/internal/maillog blitiri.com.ar/go/chasquid/internal/nettrace blitiri.com.ar/go/chasquid/internal/normalize blitiri.com.ar/go/chasquid/internal/protoio blitiri.com.ar/go/chasquid/internal/protoio/testpb blitiri.com.ar/go/chasquid/internal/queue blitiri.com.ar/go/chasquid/internal/safeio blitiri.com.ar/go/chasquid/internal/set blitiri.com.ar/go/chasquid/internal/smtp blitiri.com.ar/go/chasquid/internal/smtpsrv blitiri.com.ar/go/chasquid/internal/sts blitiri.com.ar/go/chasquid/internal/testlib blitiri.com.ar/go/chasquid/internal/tlsconst blitiri.com.ar/go/chasquid/internal/trace blitiri.com.ar/go/chasquid/internal/userdb +internal/goarch internal/unsafeheader internal/godebugs +internal/itoa +internal/goos encoding -internal/goarch +internal/goexperiment internal/coverage/rtcov -math/bits -internal/goos runtime/internal/syscall -internal/itoa -internal/goexperiment internal/cpu +math/bits runtime/internal/atomic +internal/chacha8rand +internal/abi +runtime/internal/math +runtime/internal/sys unicode/utf8 internal/race sync/atomic unicode cmp -internal/abi -internal/chacha8rand -runtime/internal/math -runtime/internal/sys log/internal internal/nettrace google.golang.org/protobuf/internal/flags @@ -426,164 +462,164 @@ container/list crypto/internal/alias crypto/subtle -crypto/internal/boring/sig +internal/bytealg vendor/golang.org/x/crypto/cryptobyte/asn1 +crypto/internal/boring/sig +math vendor/golang.org/x/crypto/internal/alias blitiri.com.ar/go/chasquid/internal/set -internal/bytealg -math runtime internal/reflectlite sync internal/testlog internal/singleflight -google.golang.org/protobuf/internal/pragma internal/bisect +google.golang.org/protobuf/internal/pragma +runtime/cgo errors sort -runtime/cgo -internal/godebug -internal/oserror strconv -path -vendor/golang.org/x/net/dns/dnsmessage io +vendor/golang.org/x/net/dns/dnsmessage +internal/oserror +internal/godebug +golang.org/x/text/internal/tag internal/safefilepath +path crypto/internal/nistec/fiat -reflect -text/tabwriter +syscall +hash +bytes crypto/internal/randutil -crypto/rc4 +text/tabwriter strings -math/rand internal/intern -hash -golang.org/x/text/internal/tag -bytes -syscall -net/netip +math/rand hash/fnv -crypto hash/crc32 vendor/golang.org/x/text/transform golang.org/x/text/transform +reflect +net/netip +crypto +crypto/rc4 +bufio +golang.org/x/text/runes html regexp/syntax net/http/internal/ascii -bufio -golang.org/x/text/runes golang.org/x/text/width regexp -internal/fmtsort -encoding/binary -internal/syscall/execenv time +internal/syscall/execenv internal/syscall/unix +io/fs +context +internal/poll +internal/fmtsort +encoding/binary +embed +google.golang.org/protobuf/internal/editiondefaults encoding/base64 -crypto/cipher crypto/internal/edwards25519/field -vendor/golang.org/x/crypto/internal/poly1305 +crypto/cipher crypto/md5 +crypto/internal/nistec +vendor/golang.org/x/crypto/internal/poly1305 +golang.org/x/sys/unix +os encoding/pem crypto/internal/boring -crypto/des vendor/golang.org/x/crypto/chacha20 -crypto/aes -crypto/hmac +crypto/des +crypto/internal/edwards25519 crypto/sha512 +crypto/hmac crypto/sha1 +crypto/aes crypto/sha256 -crypto/internal/edwards25519 vendor/golang.org/x/crypto/hkdf golang.org/x/crypto/pbkdf2 -io/fs -internal/poll -context -golang.org/x/sys/unix -embed +crypto/ecdh golang.org/x/crypto/scrypt -google.golang.org/protobuf/internal/editiondefaults -crypto/internal/nistec -os +fmt google.golang.org/protobuf/internal/detrand path/filepath io/ioutil blitiri.com.ar/go/chasquid/internal/safeio internal/lazyregexp -fmt -internal/sysinfo os/signal vendor/golang.org/x/sys/cpu -os/exec +internal/sysinfo vendor/golang.org/x/crypto/chacha20poly1305 -crypto/ecdh +os/exec +net log google.golang.org/protobuf/internal/errors -go/token flag +go/token compress/flate +text/template/parse +encoding/json google.golang.org/protobuf/internal/version net/url -encoding/json -text/template/parse math/big -encoding/hex google.golang.org/protobuf/encoding/protowire +encoding/hex vendor/golang.org/x/text/unicode/bidi vendor/golang.org/x/text/unicode/norm google.golang.org/protobuf/reflect/protoreflect vendor/golang.org/x/net/http2/hpack mime mime/quotedprintable -compress/gzip net/http/internal blitiri.com.ar/go/chasquid/internal/envelope +text/template golang.org/x/text/unicode/bidi golang.org/x/text/unicode/norm +compress/gzip golang.org/x/text/internal/language vendor/golang.org/x/text/secure/bidirule -text/template blitiri.com.ar/go/chasquid/internal/tlsconst internal/profile +runtime/pprof google.golang.org/protobuf/internal/encoding/messageset google.golang.org/protobuf/internal/strs google.golang.org/protobuf/internal/genid google.golang.org/protobuf/internal/order google.golang.org/protobuf/reflect/protoregistry -google.golang.org/protobuf/internal/encoding/text google.golang.org/protobuf/runtime/protoiface google.golang.org/protobuf/internal/descfmt google.golang.org/protobuf/internal/descopts golang.org/x/text/secure/bidirule -net vendor/golang.org/x/net/idna -runtime/pprof -runtime/trace -google.golang.org/protobuf/internal/encoding/defval golang.org/x/text/internal/language/compact +google.golang.org/protobuf/internal/encoding/text +runtime/trace runtime/debug golang.org/x/term -google.golang.org/protobuf/proto -golang.org/x/text/language crypto/rand +html/template crypto/elliptic crypto/internal/bigmod +google.golang.org/protobuf/proto crypto/internal/boring/bbig encoding/asn1 -html/template crypto/ed25519 crypto/dsa -golang.org/x/net/idna +golang.org/x/text/language +google.golang.org/protobuf/internal/encoding/defval testing -crypto/rsa +golang.org/x/net/idna google.golang.org/protobuf/encoding/prototext google.golang.org/protobuf/internal/filedesc -golang.org/x/text/internal -vendor/golang.org/x/crypto/cryptobyte crypto/x509/pkix -golang.org/x/text/cases +vendor/golang.org/x/crypto/cryptobyte +crypto/rsa +golang.org/x/text/internal blitiri.com.ar/go/chasquid/internal/protoio crypto/ecdsa +golang.org/x/text/cases golang.org/x/text/secure/precis google.golang.org/protobuf/internal/encoding/tag google.golang.org/protobuf/internal/impl @@ -595,35 +631,35 @@ log/syslog vendor/golang.org/x/net/http/httpproxy blitiri.com.ar/go/spf +blitiri.com.ar/go/chasquid/internal/haproxy +blitiri.com.ar/go/systemd crypto/x509 net/textproto -blitiri.com.ar/go/systemd -blitiri.com.ar/go/chasquid/internal/haproxy blitiri.com.ar/go/log -blitiri.com.ar/go/chasquid/internal/config vendor/golang.org/x/net/http/httpguts blitiri.com.ar/go/chasquid/internal/dovecot -blitiri.com.ar/go/chasquid/cmd/mda-lmtp -mime/multipart net/mail +mime/multipart +blitiri.com.ar/go/chasquid/cmd/mda-lmtp +blitiri.com.ar/go/chasquid/internal/config crypto/tls net/http/httptrace blitiri.com.ar/go/chasquid/internal/testlib net/smtp net/http blitiri.com.ar/go/chasquid/internal/smtp -expvar blitiri.com.ar/go/chasquid/internal/nettrace golang.org/x/net/context/ctxhttp +expvar net/http/pprof blitiri.com.ar/go/chasquid/internal/expvarom blitiri.com.ar/go/chasquid/internal/trace blitiri.com.ar/go/chasquid/internal/domaininfo blitiri.com.ar/go/chasquid/internal/sts blitiri.com.ar/go/chasquid/internal/localrpc +blitiri.com.ar/go/chasquid/internal/maillog blitiri.com.ar/go/chasquid/internal/aliases blitiri.com.ar/go/chasquid/internal/auth -blitiri.com.ar/go/chasquid/internal/maillog blitiri.com.ar/go/chasquid/cmd/chasquid-util blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/courier @@ -666,7 +702,7 @@ _ aliases.go:547 Hook.Alias-Resolve a@localA: error: exit status 1 _ aliases.go:547 Hook.Alias-Resolve *@localA: error: exit status 1 _ aliases.go:547 Hook.Alias-Resolve a@localA: error: exit status 1 ---- PASS: TestHookError (0.00s) +--- PASS: TestHookError (0.01s) === RUN FuzzReader === RUN FuzzReader/seed#0 === RUN FuzzReader/1c24d2215db69748c6fd16797673ad11ebc7e6167fe1bc1f54c6959ec10407b6 @@ -682,7 +718,7 @@ --- PASS: FuzzReader/c9c80ba9f513841cb081fe9bb7439d36f9f7a06bb999d4c39441991ccc878a9e (0.00s) --- PASS: FuzzReader/d40a98862ed393eb712e47a91bcef18e6f24cf368bb4bd248c7a7101ef8e178d (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/aliases 0.015s +ok blitiri.com.ar/go/chasquid/internal/aliases 0.019s === RUN TestDecodeResponse auth_test.go:56: OK: "" failed with response pieces != 3, as per RFC auth_test.go:56: OK: "\x00" failed with response pieces != 3, as per RFC @@ -695,11 +731,11 @@ auth_test.go:56: OK: "\xffa@b\x00\xffa@b\x00pass" failed with bidirule: failed Bidi Rule --- PASS: TestDecodeResponse (0.00s) === RUN TestAuthenticate ---- PASS: TestAuthenticate (0.34s) +--- PASS: TestAuthenticate (0.36s) === RUN TestInterfaces --- PASS: TestInterfaces (0.00s) === RUN TestMultipleBackends ---- PASS: TestMultipleBackends (0.18s) +--- PASS: TestMultipleBackends (0.19s) === RUN TestErrors --- PASS: TestErrors (0.00s) === RUN TestReload @@ -728,28 +764,27 @@ --- PASS: FuzzDecodeResponse/d9aa9c617d1f5b3021aca758b9d896d136e3b16ed53233d02abffd02aa73ffa4 (0.00s) --- PASS: FuzzDecodeResponse/de05c7993312bab83e8114e9d9ced331c49822dc55c1a353f1cc9718a28226e7 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/auth 0.527s +ok blitiri.com.ar/go/chasquid/internal/auth 0.553s === RUN TestEmptyStruct --- PASS: TestEmptyStruct (0.00s) === RUN TestEmptyConfig - testlib.go:32: test directory: "/tmp/testlib_2447607365" + testlib.go:32: test directory: "/tmp/testlib_2241620131" --- PASS: TestEmptyConfig (0.00s) === RUN TestFullConfig - testlib.go:32: test directory: "/tmp/testlib_1605728019" + testlib.go:32: test directory: "/tmp/testlib_2169980917" --- PASS: TestFullConfig (0.00s) === RUN TestErrorLoading --- PASS: TestErrorLoading (0.00s) === RUN TestBrokenConfig - testlib.go:32: test directory: "/tmp/testlib_3724540336" + testlib.go:32: test directory: "/tmp/testlib_3633881357" --- PASS: TestBrokenConfig (0.00s) === RUN TestBrokenOverride - testlib.go:32: test directory: "/tmp/testlib_810641040" + testlib.go:32: test directory: "/tmp/testlib_1482452982" --- PASS: TestBrokenOverride (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/config 0.010s -? blitiri.com.ar/go/chasquid/internal/protoio/testpb [no test files] +ok blitiri.com.ar/go/chasquid/internal/config 0.015s === RUN TestMDA - testlib.go:32: test directory: "/tmp/testlib_1716113177" + testlib.go:32: test directory: "/tmp/testlib_4030181064" --- PASS: TestMDA (0.00s) === RUN TestMDATimeout _ mda.go:73 Courier.MDA to@local: error: operation timed out @@ -764,10 +799,10 @@ === RUN TestSanitize --- PASS: TestSanitize (0.00s) === RUN TestSMTP - testlib.go:32: test directory: "/tmp/testlib_1931250242" - testlib.go:32: test directory: "/tmp/testlib_124306249" -_ smtp.go:127 Courier.SMTP to@to: error: Could not dial: dial tcp: address ::::33853: too many colons in address -_ smtp.go:101 Courier.SMTP to@to: error: \":::\" returned transient error: Could not dial: dial tcp: address ::::33853: too many colons in address + testlib.go:32: test directory: "/tmp/testlib_1255724661" + testlib.go:32: test directory: "/tmp/testlib_278928152" +_ smtp.go:127 Courier.SMTP to@to: error: Could not dial: dial tcp: address ::::32941: too many colons in address +_ smtp.go:101 Courier.SMTP to@to: error: \":::\" returned transient error: Could not dial: dial tcp: address ::::32941: too many colons in address fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -775,26 +810,26 @@ fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestSMTP (0.03s) +--- PASS: TestSMTP (0.11s) === RUN TestSMTPErrors - testlib.go:32: test directory: "/tmp/testlib_3953410957" - testlib.go:32: test directory: "/tmp/testlib_854583073" + testlib.go:32: test directory: "/tmp/testlib_2294437324" + testlib.go:32: test directory: "/tmp/testlib_2119301824" fakeserver_test.go:98: fakeServer got connection -_ smtp.go:138 Courier.SMTP to@to: error: Error saying hello: write tcp 127.0.0.1:53498->127.0.0.1:35901: i/o timeout -_ smtp.go:101 Courier.SMTP to@to: error: \"127.0.0.1\" returned transient error: Error saying hello: write tcp 127.0.0.1:53498->127.0.0.1:35901: i/o timeout -_ smtp.go:105 Courier.SMTP to@to: error: all MXs returned transient failures (last: Error saying hello: write tcp 127.0.0.1:53498->127.0.0.1:35901: i/o timeout) - smtp_test.go:140: failed as expected: all MXs returned transient failures (last: Error saying hello: write tcp 127.0.0.1:53498->127.0.0.1:35901: i/o timeout) +_ smtp.go:138 Courier.SMTP to@to: error: Error saying hello: write tcp 127.0.0.1:42970->127.0.0.1:45051: i/o timeout +_ smtp.go:101 Courier.SMTP to@to: error: \"127.0.0.1\" returned transient error: Error saying hello: write tcp 127.0.0.1:42970->127.0.0.1:45051: i/o timeout +_ smtp.go:105 Courier.SMTP to@to: error: all MXs returned transient failures (last: Error saying hello: write tcp 127.0.0.1:42970->127.0.0.1:45051: i/o timeout) + smtp_test.go:140: failed as expected: all MXs returned transient failures (last: Error saying hello: write tcp 127.0.0.1:42970->127.0.0.1:45051: i/o timeout) fakeserver_test.go:105: fakeServer exiting: EOF - testlib.go:32: test directory: "/tmp/testlib_2178637551" - testlib.go:32: test directory: "/tmp/testlib_2160007481" + testlib.go:32: test directory: "/tmp/testlib_1735639614" + testlib.go:32: test directory: "/tmp/testlib_4078463036" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" _ smtp.go:202 Courier.SMTP to@to: error: MAIL+RCPT 501 mail error smtp_test.go:140: failed as expected: MAIL+RCPT 501 mail error fakeserver_test.go:105: fakeServer exiting: EOF - testlib.go:32: test directory: "/tmp/testlib_3423432245" - testlib.go:32: test directory: "/tmp/testlib_217065592" + testlib.go:32: test directory: "/tmp/testlib_2519323106" + testlib.go:32: test directory: "/tmp/testlib_4124192430" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -802,8 +837,8 @@ _ smtp.go:202 Courier.SMTP to@to: error: MAIL+RCPT 501 rcpt error smtp_test.go:140: failed as expected: MAIL+RCPT 501 rcpt error fakeserver_test.go:105: fakeServer exiting: EOF - testlib.go:32: test directory: "/tmp/testlib_1143022180" - testlib.go:32: test directory: "/tmp/testlib_487365083" + testlib.go:32: test directory: "/tmp/testlib_548697142" + testlib.go:32: test directory: "/tmp/testlib_3357058674" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -812,8 +847,8 @@ _ smtp.go:207 Courier.SMTP to@to: error: DATA 554 data error smtp_test.go:140: failed as expected: DATA 554 data error fakeserver_test.go:132: fakeServer exiting: unexpected EOF - testlib.go:32: test directory: "/tmp/testlib_3837742522" - testlib.go:32: test directory: "/tmp/testlib_348254413" + testlib.go:32: test directory: "/tmp/testlib_1454564079" + testlib.go:32: test directory: "/tmp/testlib_3267958414" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -822,9 +857,9 @@ _ smtp.go:216 Courier.SMTP to@to: error: DATA closing 551 data response error smtp_test.go:140: failed as expected: DATA closing 551 data response error fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestSMTPErrors (1.22s) +--- PASS: TestSMTPErrors (1.20s) === RUN TestNoMXServer - testlib.go:32: test directory: "/tmp/testlib_3138934008" + testlib.go:32: test directory: "/tmp/testlib_2695076194" _ smtp.go:82 Courier.SMTP to@to: error: Could not find mail server: smtp_test.go:158: got permanent failure, as expected: Could not find mail server: --- PASS: TestNoMXServer (0.00s) @@ -839,8 +874,8 @@ === RUN TestLookupInvalidDomain --- PASS: TestLookupInvalidDomain (0.00s) === RUN TestTLS - testlib.go:32: test directory: "/tmp/testlib_808930402" - testlib.go:32: test directory: "/tmp/testlib_2356857130" + testlib.go:32: test directory: "/tmp/testlib_1424954398" + testlib.go:32: test directory: "/tmp/testlib_3235928653" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -851,7 +886,7 @@ fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF - testlib.go:32: test directory: "/tmp/testlib_2949083838" + testlib.go:32: test directory: "/tmp/testlib_4109771792" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" _ domaininfo.go:145 DomainInfo.Outgoing to: error: to outgoing denied: PLAIN < TLS_INSECURE @@ -861,8 +896,8 @@ fakeserver_test.go:105: fakeServer exiting: EOF --- PASS: TestTLS (0.06s) === RUN TestTLSError - testlib.go:32: test directory: "/tmp/testlib_754620817" - testlib.go:32: test directory: "/tmp/testlib_1267330959" + testlib.go:32: test directory: "/tmp/testlib_4122087034" + testlib.go:32: test directory: "/tmp/testlib_709947694" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -875,10 +910,10 @@ fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestTLSError (0.03s) +--- PASS: TestTLSError (0.02s) === RUN TestSTSPolicyEnforcement - testlib.go:32: test directory: "/tmp/testlib_3171916081" - testlib.go:32: test directory: "/tmp/testlib_1912160140" + testlib.go:32: test directory: "/tmp/testlib_3487438784" + testlib.go:32: test directory: "/tmp/testlib_150046838" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -886,7 +921,7 @@ _ domaininfo.go:153 DomainInfo.Outgoing to: to outgoing level raised: TLS_INSECURE > PLAIN _ smtp.go:194 test test: error: invalid security level (TLS_INSECURE) for STS policy fakeserver_test.go:105: fakeServer exiting: EOF - testlib.go:32: test directory: "/tmp/testlib_529695763" + testlib.go:32: test directory: "/tmp/testlib_2252883322" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -897,27 +932,27 @@ fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestSTSPolicyEnforcement (0.07s) +--- PASS: TestSTSPolicyEnforcement (0.11s) PASS -ok blitiri.com.ar/go/chasquid/internal/courier 1.519s +ok blitiri.com.ar/go/chasquid/internal/courier 1.615s === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_2360471288" + testlib.go:32: test directory: "/tmp/testlib_1210685870" _ domaininfo.go:117 DomainInfo.Incoming d1: d1 incoming level raised: TLS_SECURE > PLAIN _ domaininfo.go:109 DomainInfo.Incoming d1: error: d1 incoming denied: TLS_INSECURE < TLS_SECURE _ domaininfo.go:153 DomainInfo.Outgoing d1: d1 outgoing level raised: TLS_SECURE > PLAIN _ domaininfo.go:145 DomainInfo.Outgoing d1: error: d1 outgoing denied: TLS_INSECURE < TLS_SECURE _ domaininfo.go:109 DomainInfo.Incoming d1: error: d1 incoming denied: TLS_INSECURE < TLS_SECURE _ domaininfo.go:182 DomainInfo.SetToPlain d1: set to plain ---- PASS: TestBasic (0.06s) +--- PASS: TestBasic (0.01s) === RUN TestNewDomain - testlib.go:32: test directory: "/tmp/testlib_805930309" + testlib.go:32: test directory: "/tmp/testlib_4088848193" _ domaininfo.go:153 DomainInfo.Outgoing insecure: insecure outgoing level raised: TLS_INSECURE > PLAIN _ domaininfo.go:117 DomainInfo.Incoming insecure: insecure incoming level raised: TLS_INSECURE > PLAIN _ domaininfo.go:153 DomainInfo.Outgoing secure: secure outgoing level raised: TLS_SECURE > PLAIN _ domaininfo.go:117 DomainInfo.Incoming secure: secure incoming level raised: TLS_SECURE > PLAIN ---- PASS: TestNewDomain (0.02s) +--- PASS: TestNewDomain (0.08s) === RUN TestProgressions - testlib.go:32: test directory: "/tmp/testlib_3769117238" + testlib.go:32: test directory: "/tmp/testlib_2327694715" _ domaininfo.go:117 DomainInfo.Incoming pisis: pisis incoming level raised: TLS_INSECURE > PLAIN _ domaininfo.go:153 DomainInfo.Outgoing pisis: pisis outgoing level raised: TLS_INSECURE > PLAIN _ domaininfo.go:117 DomainInfo.Incoming pisis: pisis incoming level raised: TLS_SECURE > TLS_INSECURE @@ -930,29 +965,29 @@ _ domaininfo.go:145 DomainInfo.Outgoing ssip: error: ssip outgoing denied: TLS_INSECURE < TLS_SECURE _ domaininfo.go:109 DomainInfo.Incoming ssip: error: ssip incoming denied: PLAIN < TLS_SECURE _ domaininfo.go:145 DomainInfo.Outgoing ssip: error: ssip outgoing denied: PLAIN < TLS_SECURE ---- PASS: TestProgressions (0.05s) +--- PASS: TestProgressions (0.60s) === RUN TestErrors - testlib.go:32: test directory: "/tmp/testlib_1113150618" + testlib.go:32: test directory: "/tmp/testlib_3809461887" _ domaininfo.go:117 DomainInfo.Incoming d1: d1 incoming level raised: TLS_SECURE > PLAIN _ domaininfo.go:67 DomainInfo.Reload reload: error: id \"d1\": proto: syntax error (line 1:1): invalid field name: invalid-text-protobuf-contents _ domaininfo.go:67 DomainInfo.Reload reload: error: id \"d1\": proto: syntax error (line 1:1): invalid field name: invalid-text-protobuf-contents ---- PASS: TestErrors (0.01s) +--- PASS: TestErrors (0.08s) === RUN TestDirectoryErrors - testlib.go:32: test directory: "/tmp/testlib_1627539575" -_ domaininfo.go:59 DomainInfo.Reload reload: error: open /tmp/testlib_1627539575/db: no such file or directory -_ domaininfo.go:84 DomainInfo.write d1: error: open /tmp/testlib_1627539575/db/.s:d11084465100: no such file or directory + testlib.go:32: test directory: "/tmp/testlib_1347520794" +_ domaininfo.go:59 DomainInfo.Reload reload: error: open /tmp/testlib_1347520794/db: no such file or directory +_ domaininfo.go:84 DomainInfo.write d1: error: open /tmp/testlib_1347520794/db/.s:d12363491212: no such file or directory --- PASS: TestDirectoryErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/domaininfo 0.149s +ok blitiri.com.ar/go/chasquid/internal/domaininfo 0.788s === RUN TestUsernameNotSafe --- PASS: TestUsernameNotSafe (0.00s) === RUN TestAutodetect - testlib.go:32: test directory: "/tmp/testlib_2871567865" + testlib.go:32: test directory: "/tmp/testlib_2571177729" --- PASS: TestAutodetect (0.00s) === RUN TestReload --- PASS: TestReload (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/dovecot 0.005s +ok blitiri.com.ar/go/chasquid/internal/dovecot 0.009s === RUN TestSplit --- PASS: TestSplit (0.00s) === RUN TestDomainIn @@ -960,7 +995,7 @@ === RUN TestAddHeader --- PASS: TestAddHeader (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/envelope 0.002s +ok blitiri.com.ar/go/chasquid/internal/envelope 0.004s === RUN TestHandler --- PASS: TestHandler (0.00s) === RUN TestMapLabelAccident @@ -991,21 +1026,21 @@ haproxy_test.go:69: testing 18: PROXY TCP6 5::5 6::6 7777 8888 --- PASS: TestBasic (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/haproxy 0.004s +ok blitiri.com.ar/go/chasquid/internal/haproxy 0.006s === RUN TestBadServer - asm_amd64.s:1695: FakeServer &{{0xc00009a480}}: accepted - asm_amd64.s:1695: FakeServer &{{0xc00009a480}}: readRequest: "" "" / EOF - asm_amd64.s:1695: FakeServer &{{0xc00009a480}}: writeMessage("xxx"): 0 write unix /tmp/rpc-test-114373925/rpc.sock->@: write: broken pipe - asm_amd64.s:1695: FakeServer &{{0xc00009a480}}: closing - asm_amd64.s:1695: FakeServer &{{0xc00009a600}}: accepted - asm_amd64.s:1695: FakeServer &{{0xc00009a600}}: readRequest: "Echo" "" / - asm_amd64.s:1695: FakeServer &{{0xc00009a600}}: writeMessage("xxx"): 3 - asm_amd64.s:1695: FakeServer &{{0xc00009a600}}: closing + asm_amd64.s:1695: FakeServer &{{0xc0000c4d80}}: accepted + asm_amd64.s:1695: FakeServer &{{0xc0000c4d80}}: readRequest: "" "" / EOF + asm_amd64.s:1695: FakeServer &{{0xc0000c4d80}}: writeMessage("xxx"): 0 write unix /tmp/rpc-test-622166084/rpc.sock->@: write: broken pipe + asm_amd64.s:1695: FakeServer &{{0xc0000c4d80}}: closing + asm_amd64.s:1695: FakeServer &{{0xc0000c4f00}}: accepted + asm_amd64.s:1695: FakeServer &{{0xc0000c4f00}}: readRequest: "Echo" "" / + asm_amd64.s:1695: FakeServer &{{0xc0000c4f00}}: writeMessage("xxx"): 3 + asm_amd64.s:1695: FakeServer &{{0xc0000c4f00}}: closing --- PASS: TestBadServer (0.01s) === RUN TestBadSocket --- PASS: TestBadSocket (0.00s) === RUN TestEndToEnd -_ localrpc.go:63 LocalRPC.Server /tmp/rpc-test-923982423/sock: Listening +_ localrpc.go:63 LocalRPC.Server /tmp/rpc-test-2076461620/sock: Listening === RUN TestEndToEnd/Echo === RUN TestEndToEnd/Echo#01 === RUN TestEndToEnd/Hola @@ -1013,7 +1048,7 @@ _ localrpc.go:139 LocalRPC.Handle @: error: -> 500 test error === RUN TestEndToEnd/UnknownMethod _ localrpc.go:139 LocalRPC.Handle @: error: -> 500 unknown method -_ localrpc.go:67 LocalRPC.Server /tmp/rpc-test-923982423/sock: error: Accept error: accept unix /tmp/rpc-test-923982423/sock: use of closed network connection +_ localrpc.go:67 LocalRPC.Server /tmp/rpc-test-2076461620/sock: error: Accept error: accept unix /tmp/rpc-test-2076461620/sock: use of closed network connection --- PASS: TestEndToEnd (0.01s) --- PASS: TestEndToEnd/Echo (0.00s) --- PASS: TestEndToEnd/Echo#01 (0.00s) @@ -1028,7 +1063,7 @@ === RUN TestShortReadRequest --- PASS: TestShortReadRequest (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/localrpc 0.031s +ok blitiri.com.ar/go/chasquid/internal/localrpc 0.032s === RUN TestLogger --- PASS: TestLogger (0.00s) === RUN TestDefault @@ -1036,7 +1071,8 @@ === RUN TestFailedLogger --- PASS: TestFailedLogger (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/maillog 0.010s +ok blitiri.com.ar/go/chasquid/internal/maillog 0.006s +? blitiri.com.ar/go/chasquid/internal/protoio/testpb [no test files] === RUN TestContext --- PASS: TestContext (0.00s) === RUN TestHistogramBasic @@ -1050,7 +1086,7 @@ === RUN TestHTTPErrors --- PASS: TestHTTPErrors (0.01s) === RUN TestHTTPUroboro ---- PASS: TestHTTPUroboro (0.00s) +--- PASS: TestHTTPUroboro (0.01s) === RUN TestHTTPDeep --- PASS: TestHTTPDeep (0.00s) === RUN TestStripZeros @@ -1134,38 +1170,38 @@ PASS ok blitiri.com.ar/go/chasquid/internal/normalize 0.005s === RUN TestBin - testlib.go:32: test directory: "/tmp/testlib_272293471" + testlib.go:32: test directory: "/tmp/testlib_3780860334" --- PASS: TestBin (0.00s) === RUN TestText - testlib.go:32: test directory: "/tmp/testlib_2779160906" + testlib.go:32: test directory: "/tmp/testlib_3436469936" --- PASS: TestText (0.00s) === RUN TestStore - testlib.go:32: test directory: "/tmp/testlib_3270597563" + testlib.go:32: test directory: "/tmp/testlib_3866310494" --- PASS: TestStore (0.00s) === RUN TestFileErrors - testlib.go:32: test directory: "/tmp/testlib_3569955796" + testlib.go:32: test directory: "/tmp/testlib_3966532149" --- PASS: TestFileErrors (0.00s) === RUN TestMarshalErrors - testlib.go:32: test directory: "/tmp/testlib_1414117360" + testlib.go:32: test directory: "/tmp/testlib_3126813958" --- PASS: TestMarshalErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/protoio 0.036s +ok blitiri.com.ar/go/chasquid/internal/protoio 0.009s === RUN TestDSN dsn_test.go:49: From: Mail Delivery System To: Subject: Mail delivery failed: returning message to sender - Message-ID: - Date: Thu, 09 May 2024 06:43:34 +0000 + Message-ID: + Date: Wed, 11 Jun 2025 13:08:56 +0000 In-Reply-To: References: X-Failed-Recipients: pepe@africa.org, ñaca@africa.org, Auto-Submitted: auto-replied MIME-Version: 1.0 Content-Type: multipart/report; report-type=delivery-status; - boundary="2Oj0YVqkPM0" + boundary="808gqIbmLGM" - --2Oj0YVqkPM0 + --808gqIbmLGM Content-Type: text/plain; charset="utf-8" Content-Disposition: inline Content-Description: Notification @@ -1190,7 +1226,7 @@ oh! the humanity! - --2Oj0YVqkPM0 + --808gqIbmLGM Content-Type: message/global-delivery-status Content-Description: Delivery Report Content-Transfer-Encoding: 8bit @@ -1221,7 +1257,7 @@ - --2Oj0YVqkPM0 + --808gqIbmLGM Content-Type: message/rfc822 Content-Description: Undelivered Message Content-Transfer-Encoding: 8bit @@ -1231,73 +1267,70 @@ Data ñaca. - --2Oj0YVqkPM0-- + --808gqIbmLGM-- --- PASS: TestDSN (0.00s) === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_2957655935" -_ queue.go:308 Queue.SendLoop _onDG45iOSA: from from -_ queue.go:367 Queue.SendLoop _onDG45iOSA: nodomain sent -_ queue.go:367 Queue.SendLoop _onDG45iOSA: am@loco sent -_ queue.go:367 Queue.SendLoop _onDG45iOSA: x@remote sent -_ queue.go:342 Queue.SendLoop _onDG45iOSA: all done ---- PASS: TestBasic (0.06s) + testlib.go:32: test directory: "/tmp/testlib_3873623606" +_ queue.go:308 Queue.SendLoop L4n-OKIia7s: from from +_ queue.go:367 Queue.SendLoop L4n-OKIia7s: nodomain sent +_ queue.go:367 Queue.SendLoop L4n-OKIia7s: am@loco sent +_ queue.go:367 Queue.SendLoop L4n-OKIia7s: x@remote sent +_ queue.go:342 Queue.SendLoop L4n-OKIia7s: all done +--- PASS: TestBasic (0.24s) === RUN TestDSNOnTimeout - testlib.go:32: test directory: "/tmp/testlib_2032425627" -_ queue.go:308 Queue.SendLoop K1NEjojio8U: from from@loco -_ queue.go:465 Queue.SendLoop K1NEjojio8U: queued DSN: pNsOZdGyQz4 -_ queue.go:342 Queue.SendLoop K1NEjojio8U: all done -_ queue.go:308 Queue.SendLoop pNsOZdGyQz4: from <> -_ queue.go:367 Queue.SendLoop pNsOZdGyQz4: from@loco sent -_ queue.go:342 Queue.SendLoop pNsOZdGyQz4: all done + testlib.go:32: test directory: "/tmp/testlib_2985970596" +_ queue.go:308 Queue.SendLoop cFgK9BapP8U: from from@loco +_ queue.go:465 Queue.SendLoop cFgK9BapP8U: queued DSN: KL8VxEYIteI +_ queue.go:342 Queue.SendLoop cFgK9BapP8U: all done +_ queue.go:308 Queue.SendLoop KL8VxEYIteI: from <> +_ queue.go:367 Queue.SendLoop KL8VxEYIteI: from@loco sent +_ queue.go:342 Queue.SendLoop KL8VxEYIteI: all done --- PASS: TestDSNOnTimeout (0.00s) === RUN TestAliases - testlib.go:32: test directory: "/tmp/testlib_1159267964" -_ queue.go:308 Queue.SendLoop d2zhZlDogvk: from from -_ queue.go:367 Queue.SendLoop d2zhZlDogvk: ata@hualpa sent -_ queue.go:367 Queue.SendLoop d2zhZlDogvk: pq@loco sent -_ queue.go:367 Queue.SendLoop d2zhZlDogvk: rs@loco sent -_ queue.go:342 Queue.SendLoop d2zhZlDogvk: all done ---- PASS: TestAliases (0.01s) + testlib.go:32: test directory: "/tmp/testlib_1997453326" +_ queue.go:308 Queue.SendLoop 6eIR6opWn5A: from from +_ queue.go:367 Queue.SendLoop 6eIR6opWn5A: ata@hualpa sent +_ queue.go:367 Queue.SendLoop 6eIR6opWn5A: rs@loco sent +_ queue.go:367 Queue.SendLoop 6eIR6opWn5A: pq@loco sent +--- PASS: TestAliases (0.10s) +_ queue.go:342 Queue.SendLoop 6eIR6opWn5A: all done === RUN TestFullQueue - testlib.go:32: test directory: "/tmp/testlib_4035042957" + testlib.go:32: test directory: "/tmp/testlib_3035571983" _ queue.go:164 Queue.Put from: error: queue full -_ queue.go:308 Queue.SendLoop a2_bsCd1ak4: from from ---- PASS: TestFullQueue (0.00s) -_ queue.go:367 Queue.SendLoop a2_bsCd1ak4: to sent +_ queue.go:308 Queue.SendLoop 1SzH7_Jpyn8: from from +_ queue.go:367 Queue.SendLoop 1SzH7_Jpyn8: to sent +_ queue.go:342 Queue.SendLoop 1SzH7_Jpyn8: all done +--- PASS: TestFullQueue (0.02s) === RUN TestPipes -_ queue.go:375 Queue.SendLoop a2_bsCd1ak4: error: failed to write: open /tmp/testlib_4035042957/.m:a2_bsCd1ak42081958797: no such file or directory -_ queue.go:342 Queue.SendLoop a2_bsCd1ak4: all done -E queue.go:230 failed to remove queue file "/tmp/testlib_4035042957/m:a2_bsCd1ak4": remove /tmp/testlib_4035042957/m:a2_bsCd1ak4: no such file or directory - testlib.go:32: test directory: "/tmp/testlib_2830235260" + testlib.go:32: test directory: "/tmp/testlib_1811219029" --- PASS: TestPipes (0.00s) === RUN TestBadPath --- PASS: TestBadPath (0.00s) === RUN TestNextDelay --- PASS: TestNextDelay (0.00s) === RUN TestSerialization - testlib.go:32: test directory: "/tmp/testlib_3441392831" -_ queue.go:308 Queue.SendLoop aEJm2p8aR0w: from from@loco -_ queue.go:367 Queue.SendLoop aEJm2p8aR0w: to@to sent -_ queue.go:342 Queue.SendLoop aEJm2p8aR0w: all done + testlib.go:32: test directory: "/tmp/testlib_848159966" +_ queue.go:308 Queue.SendLoop h3xVaR8BxMs: from from@loco +_ queue.go:367 Queue.SendLoop h3xVaR8BxMs: to@to sent --- PASS: TestSerialization (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/queue 0.088s +ok blitiri.com.ar/go/chasquid/internal/queue 0.419s === RUN TestWriteFile - testlib.go:32: test directory: "/tmp/testlib_3343777172" ---- PASS: TestWriteFile (0.05s) + testlib.go:32: test directory: "/tmp/testlib_1999233713" +--- PASS: TestWriteFile (0.02s) === RUN TestWriteFileWithOp - testlib.go:32: test directory: "/tmp/testlib_787543963" + testlib.go:32: test directory: "/tmp/testlib_965184828" --- PASS: TestWriteFileWithOp (0.00s) === RUN TestWriteFileWithFailingOp - testlib.go:32: test directory: "/tmp/testlib_1001821870" + testlib.go:32: test directory: "/tmp/testlib_4097153728" --- PASS: TestWriteFileWithFailingOp (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/safeio 0.059s +ok blitiri.com.ar/go/chasquid/internal/safeio 0.067s === RUN TestString --- PASS: TestString (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/set 0.005s +ok blitiri.com.ar/go/chasquid/internal/set 0.047s === RUN TestIsPermanent --- PASS: TestIsPermanent (0.00s) === RUN TestIsASCII @@ -1313,20 +1346,20 @@ === RUN TestLineTooLong --- PASS: TestLineTooLong (0.01s) PASS -ok blitiri.com.ar/go/chasquid/internal/smtp 0.021s +ok blitiri.com.ar/go/chasquid/internal/smtp 0.059s ? blitiri.com.ar/go/chasquid/internal/trace [no test files] -_ server.go:242 Server listening on 127.0.0.1:34109 (SMTP) -2024-05-09 06:43:34.955089 daemon listening on 127.0.0.1:34109 -_ server.go:242 Server listening on 127.0.0.1:41385 (submission) -2024-05-09 06:43:34.955199 daemon listening on 127.0.0.1:41385 -_ server.go:242 Server listening on 127.0.0.1:45095 (submission+TLS) -2024-05-09 06:43:34.955232 daemon listening on 127.0.0.1:45095 +_ server.go:242 Server listening on 127.0.0.1:35349 (SMTP) +2025-06-11 13:08:57.245443 daemon listening on 127.0.0.1:35349 +_ server.go:242 Server listening on 127.0.0.1:39547 (submission) +2025-06-11 13:08:57.245577 daemon listening on 127.0.0.1:39547 +_ server.go:242 Server listening on 127.0.0.1:33045 (submission+TLS) +2025-06-11 13:08:57.245624 daemon listening on 127.0.0.1:33045 === RUN TestSecLevel -_ conn.go:188 SMTP.Conn 127.0.0.1:35078: error: error completing TLS handshake: EOF +_ conn.go:188 SMTP.Conn 127.0.0.1:51202: error: error completing TLS handshake: EOF _ domaininfo.go:117 DomainInfo.Incoming slc: slc incoming level raised: TLS_CLIENT > PLAIN _ domaininfo.go:109 DomainInfo.Incoming slc: error: slc incoming denied: PLAIN < TLS_CLIENT _ conn.go:538 testconn testconn: error: security level check for slc failed (PLAIN) ---- PASS: TestSecLevel (0.07s) +--- PASS: TestSecLevel (0.10s) === RUN TestIsHeader --- PASS: TestIsHeader (0.00s) === RUN TestAddrLiteral @@ -1338,224 +1371,224 @@ === RUN TestReadUntilDotReadError --- PASS: TestReadUntilDotReadError (0.00s) === RUN TestSimple -_ conn.go:689 SMTP.Conn 127.0.0.1:44686: Queued from from@from to [to@localhost] - 6yeUURMf2H0 -2024-05-09 06:43:35.132223 6yeUURMf2H0 from=from@from queued ip=127.0.0.1:44686 to=[to@localhost] -_ queue.go:308 Queue.SendLoop 6yeUURMf2H0: from from@from -_ queue.go:367 Queue.SendLoop 6yeUURMf2H0: testuser@localhost sent -2024-05-09 06:43:35.132367 6yeUURMf2H0 from=from@from to=testuser@localhost sent ---- PASS: TestSimple (0.00s) -_ queue.go:342 Queue.SendLoop 6yeUURMf2H0: all done -2024-05-09 06:43:35.132566 6yeUURMf2H0 from=from@from all done +_ conn.go:689 SMTP.Conn 127.0.0.1:47826: Queued from from@from to [to@localhost] - OlPq-q3hU40 +2025-06-11 13:08:57.470635 OlPq-q3hU40 from=from@from queued ip=127.0.0.1:47826 to=[to@localhost] +_ queue.go:308 Queue.SendLoop OlPq-q3hU40: from from@from +_ queue.go:367 Queue.SendLoop OlPq-q3hU40: testuser@localhost sent +2025-06-11 13:08:57.470771 OlPq-q3hU40 from=from@from to=testuser@localhost sent +--- PASS: TestSimple (0.03s) === RUN TestSimpleTLS -_ conn.go:689 SMTP.Conn 127.0.0.1:44692: Queued from from@from to [to@localhost] - j7msW4gmK74 -2024-05-09 06:43:35.137413 j7msW4gmK74 from=from@from queued ip=127.0.0.1:44692 to=[to@localhost] -_ queue.go:308 Queue.SendLoop j7msW4gmK74: from from@from -_ queue.go:367 Queue.SendLoop j7msW4gmK74: testuser@localhost sent -2024-05-09 06:43:35.137492 j7msW4gmK74 from=from@from to=testuser@localhost sent ---- PASS: TestSimpleTLS (0.01s) -_ queue.go:342 Queue.SendLoop j7msW4gmK74: all done +_ queue.go:342 Queue.SendLoop OlPq-q3hU40: all done +2025-06-11 13:08:57.568973 OlPq-q3hU40 from=from@from all done +_ conn.go:689 SMTP.Conn 127.0.0.1:47830: Queued from from@from to [to@localhost] - PJa-HGU_1e8 +2025-06-11 13:08:57.569154 PJa-HGU_1e8 from=from@from queued ip=127.0.0.1:47830 to=[to@localhost] +_ queue.go:308 Queue.SendLoop PJa-HGU_1e8: from from@from +_ queue.go:367 Queue.SendLoop PJa-HGU_1e8: testuser@localhost sent +2025-06-11 13:08:57.569274 PJa-HGU_1e8 from=from@from to=testuser@localhost sent +--- PASS: TestSimpleTLS (0.10s) === RUN TestManyEmails -2024-05-09 06:43:35.137650 j7msW4gmK74 from=from@from all done -_ conn.go:689 SMTP.Conn 127.0.0.1:44698: Queued from from@from to [to@localhost] - w1DEOOCCzXI -2024-05-09 06:43:35.141725 w1DEOOCCzXI from=from@from queued ip=127.0.0.1:44698 to=[to@localhost] -_ queue.go:308 Queue.SendLoop w1DEOOCCzXI: from from@from -_ queue.go:367 Queue.SendLoop w1DEOOCCzXI: testuser@localhost sent -2024-05-09 06:43:35.141968 w1DEOOCCzXI from=from@from to=testuser@localhost sent -_ conn.go:689 SMTP.Conn 127.0.0.1:44698: Queued from from@from to [to@localhost] - gUvOCIZR0b0 -2024-05-09 06:43:35.142550 gUvOCIZR0b0 from=from@from queued ip=127.0.0.1:44698 to=[to@localhost] -_ queue.go:308 Queue.SendLoop gUvOCIZR0b0: from from@from -_ queue.go:367 Queue.SendLoop gUvOCIZR0b0: testuser@localhost sent -2024-05-09 06:43:35.142661 gUvOCIZR0b0 from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop w1DEOOCCzXI: all done -2024-05-09 06:43:35.142691 w1DEOOCCzXI from=from@from all done -_ queue.go:342 Queue.SendLoop gUvOCIZR0b0: all done -2024-05-09 06:43:35.142882 gUvOCIZR0b0 from=from@from all done -_ conn.go:689 SMTP.Conn 127.0.0.1:44698: Queued from from@from to [to@localhost] - zlBWq1e7RoU -2024-05-09 06:43:35.149369 zlBWq1e7RoU from=from@from queued ip=127.0.0.1:44698 to=[to@localhost] -_ queue.go:308 Queue.SendLoop zlBWq1e7RoU: from from@from -_ queue.go:367 Queue.SendLoop zlBWq1e7RoU: testuser@localhost sent -2024-05-09 06:43:35.149469 zlBWq1e7RoU from=from@from to=testuser@localhost sent ---- PASS: TestManyEmails (0.01s) -_ queue.go:342 Queue.SendLoop zlBWq1e7RoU: all done -2024-05-09 06:43:35.149652 zlBWq1e7RoU from=from@from all done +_ queue.go:342 Queue.SendLoop PJa-HGU_1e8: all done +2025-06-11 13:08:57.581070 PJa-HGU_1e8 from=from@from all done +_ conn.go:689 SMTP.Conn 127.0.0.1:47836: Queued from from@from to [to@localhost] - l4D1wlPNeKk +2025-06-11 13:08:57.581677 l4D1wlPNeKk from=from@from queued ip=127.0.0.1:47836 to=[to@localhost] +_ queue.go:308 Queue.SendLoop l4D1wlPNeKk: from from@from +_ queue.go:367 Queue.SendLoop l4D1wlPNeKk: testuser@localhost sent +2025-06-11 13:08:57.581944 l4D1wlPNeKk from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop l4D1wlPNeKk: all done +2025-06-11 13:08:57.582225 l4D1wlPNeKk from=from@from all done +_ queue.go:308 Queue.SendLoop XjuCRTt9Nwc: from from@from +_ queue.go:367 Queue.SendLoop XjuCRTt9Nwc: testuser@localhost sent +2025-06-11 13:08:57.583745 XjuCRTt9Nwc from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop XjuCRTt9Nwc: all done +2025-06-11 13:08:57.583990 XjuCRTt9Nwc from=from@from all done +_ conn.go:689 SMTP.Conn 127.0.0.1:47836: Queued from from@from to [to@localhost] - XjuCRTt9Nwc +2025-06-11 13:08:57.584069 XjuCRTt9Nwc from=from@from queued ip=127.0.0.1:47836 to=[to@localhost] +_ conn.go:689 SMTP.Conn 127.0.0.1:47836: Queued from from@from to [to@localhost] - 5Q0GsG68VmA +2025-06-11 13:08:57.584755 5Q0GsG68VmA from=from@from queued ip=127.0.0.1:47836 to=[to@localhost] +_ queue.go:308 Queue.SendLoop 5Q0GsG68VmA: from from@from +_ queue.go:367 Queue.SendLoop 5Q0GsG68VmA: testuser@localhost sent +2025-06-11 13:08:57.584827 5Q0GsG68VmA from=from@from to=testuser@localhost sent +--- PASS: TestManyEmails (0.02s) === RUN TestAuth -2024-05-09 06:43:35.252349 127.0.0.1:40716 auth succeeded for testuser@localhost -_ conn.go:689 SMTP.Conn 127.0.0.1:40716: Queued from testuser@localhost to [to@localhost] - DFQtbQVlYVc -2024-05-09 06:43:35.253453 DFQtbQVlYVc from=testuser@localhost queued ip=127.0.0.1:40716 to=[to@localhost] -_ queue.go:308 Queue.SendLoop DFQtbQVlYVc: from testuser@localhost -_ queue.go:367 Queue.SendLoop DFQtbQVlYVc: testuser@localhost sent -2024-05-09 06:43:35.253582 DFQtbQVlYVc from=testuser@localhost to=testuser@localhost sent ---- PASS: TestAuth (0.10s) +_ queue.go:342 Queue.SendLoop 5Q0GsG68VmA: all done +2025-06-11 13:08:57.685735 5Q0GsG68VmA from=from@from all done +2025-06-11 13:08:57.691959 127.0.0.1:42902 auth succeeded for testuser@localhost +_ conn.go:689 SMTP.Conn 127.0.0.1:42902: Queued from testuser@localhost to [to@localhost] - GVKPwhMs-nM +2025-06-11 13:08:57.692811 GVKPwhMs-nM from=testuser@localhost queued ip=127.0.0.1:42902 to=[to@localhost] +_ queue.go:308 Queue.SendLoop GVKPwhMs-nM: from testuser@localhost +_ queue.go:367 Queue.SendLoop GVKPwhMs-nM: testuser@localhost sent +2025-06-11 13:08:57.692927 GVKPwhMs-nM from=testuser@localhost to=testuser@localhost sent +--- PASS: TestAuth (0.11s) +_ queue.go:342 Queue.SendLoop GVKPwhMs-nM: all done +2025-06-11 13:08:57.693269 GVKPwhMs-nM from=testuser@localhost all done === RUN TestSubmissionWithoutAuth -_ conn.go:297 SMTP.Conn 127.0.0.1:40722: error: MAIL failed: 550 5.7.9 Mail to submission port must be authenticated +_ conn.go:297 SMTP.Conn 127.0.0.1:42908: error: MAIL failed: 550 5.7.9 Mail to submission port must be authenticated --- PASS: TestSubmissionWithoutAuth (0.00s) === RUN TestAuthOnTLS -_ queue.go:342 Queue.SendLoop DFQtbQVlYVc: all done -2024-05-09 06:43:35.313306 DFQtbQVlYVc from=testuser@localhost all done -2024-05-09 06:43:35.362874 127.0.0.1:35094 auth succeeded for testuser@localhost -_ conn.go:689 SMTP.Conn 127.0.0.1:35094: Queued from testuser@localhost to [to@localhost] - J5HT4zrM4Bo -2024-05-09 06:43:35.363771 J5HT4zrM4Bo from=testuser@localhost queued ip=127.0.0.1:35094 to=[to@localhost] -_ queue.go:308 Queue.SendLoop J5HT4zrM4Bo: from testuser@localhost -_ queue.go:367 Queue.SendLoop J5HT4zrM4Bo: testuser@localhost sent -2024-05-09 06:43:35.363878 J5HT4zrM4Bo from=testuser@localhost to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop J5HT4zrM4Bo: all done -2024-05-09 06:43:35.364089 J5HT4zrM4Bo from=testuser@localhost all done +2025-06-11 13:08:57.801750 127.0.0.1:51206 auth succeeded for testuser@localhost +_ conn.go:689 SMTP.Conn 127.0.0.1:51206: Queued from testuser@localhost to [to@localhost] - _qnh8kATkEA +2025-06-11 13:08:57.802832 _qnh8kATkEA from=testuser@localhost queued ip=127.0.0.1:51206 to=[to@localhost] +_ queue.go:308 Queue.SendLoop _qnh8kATkEA: from testuser@localhost +_ queue.go:367 Queue.SendLoop _qnh8kATkEA: testuser@localhost sent +2025-06-11 13:08:57.802979 _qnh8kATkEA from=testuser@localhost to=testuser@localhost sent --- PASS: TestAuthOnTLS (0.11s) === RUN TestAuthOnSMTP -2024-05-09 06:43:35.475598 127.0.0.1:44706 auth succeeded for testuser@localhost -_ conn.go:689 SMTP.Conn 127.0.0.1:44706: Queued from testuser@localhost to [to@localhost] - EyWM4GfqECM -2024-05-09 06:43:35.476325 EyWM4GfqECM from=testuser@localhost queued ip=127.0.0.1:44706 to=[to@localhost] -_ queue.go:308 Queue.SendLoop EyWM4GfqECM: from testuser@localhost -_ queue.go:367 Queue.SendLoop EyWM4GfqECM: testuser@localhost sent -2024-05-09 06:43:35.476433 EyWM4GfqECM from=testuser@localhost to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop _qnh8kATkEA: all done +2025-06-11 13:08:57.888516 _qnh8kATkEA from=testuser@localhost all done +2025-06-11 13:08:57.915236 127.0.0.1:47844 auth succeeded for testuser@localhost +_ conn.go:689 SMTP.Conn 127.0.0.1:47844: Queued from testuser@localhost to [to@localhost] - Q58Nn5qG91E +2025-06-11 13:08:57.916166 Q58Nn5qG91E from=testuser@localhost queued ip=127.0.0.1:47844 to=[to@localhost] +_ queue.go:308 Queue.SendLoop Q58Nn5qG91E: from testuser@localhost +_ queue.go:367 Queue.SendLoop Q58Nn5qG91E: testuser@localhost sent +2025-06-11 13:08:57.916295 Q58Nn5qG91E from=testuser@localhost to=testuser@localhost sent --- PASS: TestAuthOnSMTP (0.11s) === RUN TestBrokenAuth -_ queue.go:342 Queue.SendLoop EyWM4GfqECM: all done -2024-05-09 06:43:35.476629 EyWM4GfqECM from=testuser@localhost all done -_ conn.go:1062 SMTP.Conn 127.0.0.1:40726: error: error authenticating \"user\"@\"broken\": failed to auth -2024-05-09 06:43:35.580518 127.0.0.1:40726 auth failed for user@broken -_ conn.go:297 SMTP.Conn 127.0.0.1:40726: error: AUTH failed: 454 4.7.0 Temporary authentication failure -_ conn.go:297 SMTP.Conn 127.0.0.1:40726: error: unknown<\"*\"> failed: 500 5.5.1 Unknown command ---- PASS: TestBrokenAuth (0.10s) +_ queue.go:342 Queue.SendLoop Q58Nn5qG91E: all done +2025-06-11 13:08:57.990253 Q58Nn5qG91E from=testuser@localhost all done +_ conn.go:1062 SMTP.Conn 127.0.0.1:42924: error: error authenticating \"user\"@\"broken\": failed to auth +2025-06-11 13:08:58.028793 127.0.0.1:42924 auth failed for user@broken +_ conn.go:297 SMTP.Conn 127.0.0.1:42924: error: AUTH failed: 454 4.7.0 Temporary authentication failure +_ conn.go:297 SMTP.Conn 127.0.0.1:42924: error: unknown<\"*\"> failed: 500 5.5.1 Unknown command +--- PASS: TestBrokenAuth (0.11s) === RUN TestWrongMailParsing -_ conn.go:297 SMTP.Conn 127.0.0.1:44714: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:44714: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:44714: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:44714: error: too many errors, breaking connection -_ conn.go:297 SMTP.Conn 127.0.0.1:44724: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:44724: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:44724: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:44724: error: too many errors, breaking connection -_ conn.go:297 SMTP.Conn 127.0.0.1:44732: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:44732: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:44732: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:44732: error: too many errors, breaking connection -_ conn.go:297 SMTP.Conn 127.0.0.1:44746: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:44746: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:44746: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:44746: error: too many errors, breaking connection -_ conn.go:297 SMTP.Conn 127.0.0.1:44758: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:44758: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:44758: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:44758: error: too many errors, breaking connection -_ conn.go:297 SMTP.Conn 127.0.0.1:44770: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:44770: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:44770: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:44770: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:47854: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:47854: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:47854: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:47854: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:47864: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:47864: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:47864: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:47864: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:47866: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:47866: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:47866: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:47866: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:47870: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:47870: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:47870: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:47870: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:47886: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:47886: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:47886: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:47886: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:47892: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:47892: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:47892: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:47892: error: too many errors, breaking connection --- PASS: TestWrongMailParsing (0.00s) === RUN TestNullMailFrom --- PASS: TestNullMailFrom (0.00s) === RUN TestRcptBeforeMail -_ conn.go:297 SMTP.Conn 127.0.0.1:44790: error: RCPT failed: 503 5.5.1 Sender not yet given +_ conn.go:297 SMTP.Conn 127.0.0.1:47904: error: RCPT failed: 503 5.5.1 Sender not yet given --- PASS: TestRcptBeforeMail (0.00s) === RUN TestRcptOption --- PASS: TestRcptOption (0.00s) === RUN TestRelayForbidden -2024-05-09 06:43:35.590112 127.0.0.1:44794 rejected from=from@somewhere to=[to@somewhere] - relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:44794: error: RCPT failed: 503 5.7.1 Relay not allowed +2025-06-11 13:08:58.037993 127.0.0.1:47916 rejected from=from@somewhere to=[to@somewhere] - relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:47916: error: RCPT failed: 503 5.7.1 Relay not allowed --- PASS: TestRelayForbidden (0.00s) === RUN TestTooManyRecipients -2024-05-09 06:43:35.698043 127.0.0.1:40734 auth succeeded for testuser@localhost -_ conn.go:297 SMTP.Conn 127.0.0.1:40734: error: RCPT failed: 452 4.5.3 Too many recipients +2025-06-11 13:08:58.142784 127.0.0.1:42934 auth succeeded for testuser@localhost +_ conn.go:297 SMTP.Conn 127.0.0.1:42934: error: RCPT failed: 452 4.5.3 Too many recipients --- PASS: TestTooManyRecipients (0.11s) === RUN TestRcptBrokenExists -_ conn.go:601 SMTP.Conn 127.0.0.1:44806: error: error checking if user \"to@broken\" exists: failed to check if user exists -2024-05-09 06:43:35.703925 127.0.0.1:44806 rejected from=from@localhost to=[to@broken] - error checking if user exists: failed to check if user exists -_ conn.go:297 SMTP.Conn 127.0.0.1:44806: error: RCPT failed: 451 4.4.3 Temporary error checking address +_ conn.go:601 SMTP.Conn 127.0.0.1:47920: error: error checking if user \"to@broken\" exists: failed to check if user exists +2025-06-11 13:08:58.150272 127.0.0.1:47920 rejected from=from@localhost to=[to@broken] - error checking if user exists: failed to check if user exists +_ conn.go:297 SMTP.Conn 127.0.0.1:47920: error: RCPT failed: 451 4.4.3 Temporary error checking address --- PASS: TestRcptBrokenExists (0.00s) === RUN TestRcptUserDoesNotExist -2024-05-09 06:43:35.707492 127.0.0.1:44814 rejected from=from@localhost to=[doesnotexist@localhost] - local user does not exist -_ conn.go:297 SMTP.Conn 127.0.0.1:44814: error: RCPT failed: 550 5.1.1 Destination address is unknown (user does not exist) +2025-06-11 13:08:58.152699 127.0.0.1:47934 rejected from=from@localhost to=[doesnotexist@localhost] - local user does not exist +_ conn.go:297 SMTP.Conn 127.0.0.1:47934: error: RCPT failed: 550 5.1.1 Destination address is unknown (user does not exist) --- PASS: TestRcptUserDoesNotExist (0.00s) === RUN TestTooMuchData -_ conn.go:689 SMTP.Conn 127.0.0.1:44822: Queued from from@from to [to@localhost] - YAoXUhL-Wtg -2024-05-09 06:43:35.912954 YAoXUhL-Wtg from=from@from queued ip=127.0.0.1:44822 to=[to@localhost] -_ queue.go:308 Queue.SendLoop YAoXUhL-Wtg: from from@from -_ queue.go:367 Queue.SendLoop YAoXUhL-Wtg: testuser@localhost sent -2024-05-09 06:43:35.913223 YAoXUhL-Wtg from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop YAoXUhL-Wtg: all done -2024-05-09 06:43:36.034255 YAoXUhL-Wtg from=from@from all done -_ conn.go:689 SMTP.Conn 127.0.0.1:44822: Queued from from@from to [to@localhost] - XH17gGFNnUA -2024-05-09 06:43:36.039108 XH17gGFNnUA from=from@from queued ip=127.0.0.1:44822 to=[to@localhost] -_ queue.go:308 Queue.SendLoop XH17gGFNnUA: from from@from -_ queue.go:367 Queue.SendLoop XH17gGFNnUA: testuser@localhost sent -2024-05-09 06:43:36.039196 XH17gGFNnUA from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop XH17gGFNnUA: all done -2024-05-09 06:43:36.084855 XH17gGFNnUA from=from@from all done -_ conn.go:297 SMTP.Conn 127.0.0.1:44822: error: DATA failed: 552 5.3.4 Message too big -_ conn.go:689 SMTP.Conn 127.0.0.1:44822: Queued from from@from to [to@localhost] - eaqRW2MO38o -2024-05-09 06:43:36.243422 eaqRW2MO38o from=from@from queued ip=127.0.0.1:44822 to=[to@localhost] -_ queue.go:308 Queue.SendLoop eaqRW2MO38o: from from@from -_ queue.go:367 Queue.SendLoop eaqRW2MO38o: testuser@localhost sent -2024-05-09 06:43:36.243631 eaqRW2MO38o from=from@from to=testuser@localhost sent ---- PASS: TestTooMuchData (0.54s) +_ conn.go:689 SMTP.Conn 127.0.0.1:47948: Queued from from@from to [to@localhost] - KngHibPvjNw +2025-06-11 13:08:58.297686 KngHibPvjNw from=from@from queued ip=127.0.0.1:47948 to=[to@localhost] +_ queue.go:308 Queue.SendLoop KngHibPvjNw: from from@from +_ queue.go:367 Queue.SendLoop KngHibPvjNw: testuser@localhost sent +2025-06-11 13:08:58.297840 KngHibPvjNw from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop KngHibPvjNw: all done +2025-06-11 13:08:58.424484 KngHibPvjNw from=from@from all done +_ conn.go:689 SMTP.Conn 127.0.0.1:47948: Queued from from@from to [to@localhost] - CDMNQc9RXOE +2025-06-11 13:08:58.429364 CDMNQc9RXOE from=from@from queued ip=127.0.0.1:47948 to=[to@localhost] +_ queue.go:308 Queue.SendLoop CDMNQc9RXOE: from from@from +_ queue.go:367 Queue.SendLoop CDMNQc9RXOE: testuser@localhost sent +2025-06-11 13:08:58.429577 CDMNQc9RXOE from=from@from to=testuser@localhost sent +_ conn.go:297 SMTP.Conn 127.0.0.1:47948: error: DATA failed: 552 5.3.4 Message too big +_ queue.go:342 Queue.SendLoop CDMNQc9RXOE: all done +2025-06-11 13:08:58.522838 CDMNQc9RXOE from=from@from all done +_ conn.go:689 SMTP.Conn 127.0.0.1:47948: Queued from from@from to [to@localhost] - 2c3B9qcE6vc +_ queue.go:308 Queue.SendLoop 2c3B9qcE6vc: from from@from +_ queue.go:367 Queue.SendLoop 2c3B9qcE6vc: testuser@localhost sent +2025-06-11 13:08:58.600336 2c3B9qcE6vc from=from@from to=testuser@localhost sent +2025-06-11 13:08:58.600152 2c3B9qcE6vc from=from@from queued ip=127.0.0.1:47948 to=[to@localhost] +--- PASS: TestTooMuchData (0.45s) === RUN TestSimpleCommands -_ conn.go:297 SMTP.Conn 127.0.0.1:44828: error: VRFY failed: 502 5.5.1 You have a strange feeling for a moment, then it passes. -_ conn.go:297 SMTP.Conn 127.0.0.1:44828: error: EXPN failed: 502 5.5.1 You feel disoriented for a moment. +_ conn.go:297 SMTP.Conn 127.0.0.1:47960: error: VRFY failed: 502 5.5.1 You have a strange feeling for a moment, then it passes. +_ conn.go:297 SMTP.Conn 127.0.0.1:47960: error: EXPN failed: 502 5.5.1 You feel disoriented for a moment. --- PASS: TestSimpleCommands (0.00s) === RUN TestLongLines -_ conn.go:297 SMTP.Conn 127.0.0.1:44838: error: unknown<\"\"> failed: 500 5.5.1 Unknown command -_ conn.go:327 SMTP.Conn 127.0.0.1:44838: error: exiting with error: line too long +_ conn.go:297 SMTP.Conn 127.0.0.1:47976: error: unknown<\"\"> failed: 500 5.5.1 Unknown command +_ conn.go:327 SMTP.Conn 127.0.0.1:47976: error: exiting with error: line too long --- PASS: TestLongLines (0.00s) === RUN TestReset --- PASS: TestReset (0.00s) === RUN TestRepeatedStartTLS -_ conn.go:297 SMTP.Conn 127.0.0.1:44854: error: STARTTLS failed: 503 5.5.1 You are already wearing that! +_ conn.go:297 SMTP.Conn 127.0.0.1:47998: error: STARTTLS failed: 503 5.5.1 You are already wearing that! --- PASS: TestRepeatedStartTLS (0.00s) === RUN TestStartTLSOnTLS -_ conn.go:297 SMTP.Conn 127.0.0.1:35106: error: STARTTLS failed: 503 5.5.1 You are already wearing that! +_ conn.go:297 SMTP.Conn 127.0.0.1:51210: error: STARTTLS failed: 503 5.5.1 You are already wearing that! --- PASS: TestStartTLSOnTLS (0.00s) === RUN FuzzConnection === RUN FuzzConnection/3d7e992212e817da7afdb7a4e769ceec1d4047a2e630bec4b35ecd4d55560424 -_ conn.go:297 SMTP.Conn 127.0.0.1:44858: error: RCPT failed: 500 5.5.2 Unknown command -_ conn.go:297 SMTP.Conn 127.0.0.1:44858: error: RCPT failed: 500 5.5.4 Malformed command: EOF -_ conn.go:297 SMTP.Conn 127.0.0.1:44858: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:44858: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:48010: error: RCPT failed: 500 5.5.2 Unknown command +_ conn.go:297 SMTP.Conn 127.0.0.1:48010: error: RCPT failed: 500 5.5.4 Malformed command: EOF +_ conn.go:297 SMTP.Conn 127.0.0.1:48010: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:48010: error: too many errors, breaking connection === RUN FuzzConnection/68d8c7b5f149996ffd46ad9a15852165d8c1cbd6c03cceb9382e5add16415c94 -_ conn.go:297 SMTP.Conn 127.0.0.1:44872: error: DATA failed: 503 5.5.1 Invisible customers are not welcome! -_ conn.go:297 SMTP.Conn 127.0.0.1:44872: error: DATA failed: 503 5.5.1 Sender not yet given +_ conn.go:297 SMTP.Conn 127.0.0.1:48014: error: DATA failed: 503 5.5.1 Invisible customers are not welcome! +_ conn.go:297 SMTP.Conn 127.0.0.1:48014: error: DATA failed: 503 5.5.1 Sender not yet given +2025-06-11 13:08:58.620424 127.0.0.1:48014 rejected from=a@b to=[user@testserver] - relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:48014: error: RCPT failed: 503 5.7.1 Relay not allowed +_ conn.go:304 SMTP.Conn 127.0.0.1:48014: error: too many errors, breaking connection === RUN FuzzConnection/79e51b30c215fb19a29855deebf2ed8299b35ca6f14db9681ee504e216c44a7f -2024-05-09 06:43:36.251979 127.0.0.1:44872 rejected from=a@b to=[user@testserver] - relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:44872: error: RCPT failed: 503 5.7.1 Relay not allowed -_ conn.go:304 SMTP.Conn 127.0.0.1:44872: error: too many errors, breaking connection -2024-05-09 06:43:36.252339 127.0.0.1:44876 rejected from=<> to=[user@testserver] - relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:44876: error: RCPT failed: 503 5.7.1 Relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:44876: error: DATA failed: 503 5.5.1 Need an address to send to -_ conn.go:297 SMTP.Conn 127.0.0.1:44876: error: unknown<\"FROM:\"> failed: 500 5.5.1 Unknown command -_ conn.go:304 SMTP.Conn 127.0.0.1:44876: error: too many errors, breaking connection +2025-06-11 13:08:58.621303 127.0.0.1:48016 rejected from=<> to=[user@testserver] - relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:48016: error: RCPT failed: 503 5.7.1 Relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:48016: error: DATA failed: 503 5.5.1 Need an address to send to +_ conn.go:297 SMTP.Conn 127.0.0.1:48016: error: unknown<\"FROM:\"> failed: 500 5.5.1 Unknown command +_ conn.go:304 SMTP.Conn 127.0.0.1:48016: error: too many errors, breaking connection === RUN FuzzConnection/83ab02fccf91c1b9c0c972de745dc2a45d23dc3236f9027e605c3e017d8898fe -_ conn.go:297 SMTP.Conn 127.0.0.1:44888: error: MAIL failed: 500 5.5.2 Unknown command -_ conn.go:297 SMTP.Conn 127.0.0.1:44888: error: MAIL failed: 500 5.5.4 Malformed command: EOF -_ conn.go:297 SMTP.Conn 127.0.0.1:44888: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:304 SMTP.Conn 127.0.0.1:44888: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:48032: error: MAIL failed: 500 5.5.2 Unknown command +_ conn.go:297 SMTP.Conn 127.0.0.1:48032: error: MAIL failed: 500 5.5.4 Malformed command: EOF +_ conn.go:297 SMTP.Conn 127.0.0.1:48032: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:304 SMTP.Conn 127.0.0.1:48032: error: too many errors, breaking connection === RUN FuzzConnection/a24124ade554d7a25de538f2cbbced6245ba60e90d221e51590456e222c80359 -_ conn.go:297 SMTP.Conn 127.0.0.1:44898: error: HELO failed: 501 Invisible customers are not welcome! -_ conn.go:297 SMTP.Conn 127.0.0.1:44898: error: EHLO failed: 501 Invisible customers are not welcome! +_ conn.go:297 SMTP.Conn 127.0.0.1:48044: error: HELO failed: 501 Invisible customers are not welcome! +_ conn.go:297 SMTP.Conn 127.0.0.1:48044: error: EHLO failed: 501 Invisible customers are not welcome! === RUN FuzzConnection/b896b41db27f6e36e4e727ac4f7b3d02fad34d217855c0d433ea3a325951b3bf -_ queue.go:342 Queue.SendLoop eaqRW2MO38o: all done -2024-05-09 06:43:36.255017 eaqRW2MO38o from=from@from all done === RUN FuzzConnection/bf15e6fb937795251090940ac60a37705b36a13e71a9557e7aaf0618ea2cf661 -2024-05-09 06:43:36.255903 127.0.0.1:44918 rejected from=<> to=[user@testserver] - relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:44918: error: RCPT failed: 503 5.7.1 Relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:44918: error: DATA failed: 503 5.5.1 Need an address to send to -_ conn.go:297 SMTP.Conn 127.0.0.1:44918: error: unknown<\"FROM:\"> failed: 500 5.5.1 Unknown command -_ conn.go:304 SMTP.Conn 127.0.0.1:44918: error: too many errors, breaking connection +2025-06-11 13:08:58.624960 127.0.0.1:48066 rejected from=<> to=[user@testserver] - relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:48066: error: RCPT failed: 503 5.7.1 Relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:48066: error: DATA failed: 503 5.5.1 Need an address to send to +_ conn.go:297 SMTP.Conn 127.0.0.1:48066: error: unknown<\"FROM:\"> failed: 500 5.5.1 Unknown command +_ conn.go:304 SMTP.Conn 127.0.0.1:48066: error: too many errors, breaking connection === RUN FuzzConnection/d1b1ccbbb380c53282cc2689c4bd9ff0d03a03698e9be55371739ef95d7dd671 -_ conn.go:297 SMTP.Conn 127.0.0.1:44920: error: AUTH failed: 503 5.7.10 You feel vulnerable -_ conn.go:297 SMTP.Conn 127.0.0.1:44920: error: AUTH failed: 503 5.7.10 You feel vulnerable -_ conn.go:297 SMTP.Conn 127.0.0.1:44920: error: AUTH failed: 503 5.7.10 You feel vulnerable -_ conn.go:304 SMTP.Conn 127.0.0.1:44920: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:48076: error: AUTH failed: 503 5.7.10 You feel vulnerable +_ conn.go:297 SMTP.Conn 127.0.0.1:48076: error: AUTH failed: 503 5.7.10 You feel vulnerable +_ conn.go:297 SMTP.Conn 127.0.0.1:48076: error: AUTH failed: 503 5.7.10 You feel vulnerable +_ conn.go:304 SMTP.Conn 127.0.0.1:48076: error: too many errors, breaking connection === RUN FuzzConnection/dc70e53325976a3a1067feb0b0c956c5a9abec1c867f8198808ccff83f594ded -_ conn.go:297 SMTP.Conn 127.0.0.1:44932: error: unknown<\"WHATIS\"> failed: 500 5.5.1 Unknown command +_ conn.go:297 SMTP.Conn 127.0.0.1:48078: error: unknown<\"WHATIS\"> failed: 500 5.5.1 Unknown command === RUN FuzzConnection/e7682fde78ce0d78ddc7a818f151b6f04466a2c122197a2e4e8048d194ed72c2 -_ conn.go:297 SMTP.Conn 127.0.0.1:44938: error: AUTH failed: 503 5.7.10 You feel vulnerable +_ conn.go:297 SMTP.Conn 127.0.0.1:48080: error: AUTH failed: 503 5.7.10 You feel vulnerable === RUN FuzzConnection/fd41d0c11b1bb7f89825934b2ec51db1df166e34b4610e8089549eedf2e3635c -_ conn.go:297 SMTP.Conn 127.0.0.1:35116: error: AUTH failed: 534 5.7.9 Asmodeus demands 534 zorkmids for safe passage -_ conn.go:297 SMTP.Conn 127.0.0.1:35116: error: AUTH failed: 501 5.5.2 Error decoding AUTH response: illegal base64 data at input byte 28 -2024-05-09 06:43:36.376991 127.0.0.1:35116 auth failed for user@testserver -_ conn.go:297 SMTP.Conn 127.0.0.1:35116: error: AUTH failed: 535 5.7.8 Incorrect user or password -_ conn.go:304 SMTP.Conn 127.0.0.1:35116: error: too many errors, breaking connection ---- PASS: FuzzConnection (0.13s) +_ conn.go:297 SMTP.Conn 127.0.0.1:51222: error: AUTH failed: 534 5.7.9 Asmodeus demands 534 zorkmids for safe passage +_ conn.go:297 SMTP.Conn 127.0.0.1:51222: error: AUTH failed: 501 5.5.2 Error decoding AUTH response: illegal base64 data at input byte 28 +_ queue.go:342 Queue.SendLoop 2c3B9qcE6vc: all done +2025-06-11 13:08:58.735251 2c3B9qcE6vc from=from@from all done +2025-06-11 13:08:58.739639 127.0.0.1:51222 auth failed for user@testserver +_ conn.go:297 SMTP.Conn 127.0.0.1:51222: error: AUTH failed: 535 5.7.8 Incorrect user or password +_ conn.go:304 SMTP.Conn 127.0.0.1:51222: error: too many errors, breaking connection +--- PASS: FuzzConnection (0.12s) --- PASS: FuzzConnection/3d7e992212e817da7afdb7a4e769ceec1d4047a2e630bec4b35ecd4d55560424 (0.00s) --- PASS: FuzzConnection/68d8c7b5f149996ffd46ad9a15852165d8c1cbd6c03cceb9382e5add16415c94 (0.00s) --- PASS: FuzzConnection/79e51b30c215fb19a29855deebf2ed8299b35ca6f14db9681ee504e216c44a7f (0.00s) @@ -1566,9 +1599,9 @@ --- PASS: FuzzConnection/d1b1ccbbb380c53282cc2689c4bd9ff0d03a03698e9be55371739ef95d7dd671 (0.00s) --- PASS: FuzzConnection/dc70e53325976a3a1067feb0b0c956c5a9abec1c867f8198808ccff83f594ded (0.00s) --- PASS: FuzzConnection/e7682fde78ce0d78ddc7a818f151b6f04466a2c122197a2e4e8048d194ed72c2 (0.00s) - --- PASS: FuzzConnection/fd41d0c11b1bb7f89825934b2ec51db1df166e34b4610e8089549eedf2e3635c (0.12s) + --- PASS: FuzzConnection/fd41d0c11b1bb7f89825934b2ec51db1df166e34b4610e8089549eedf2e3635c (0.11s) PASS -ok blitiri.com.ar/go/chasquid/internal/smtpsrv 1.567s +ok blitiri.com.ar/go/chasquid/internal/smtpsrv 1.599s === RUN TestParsePolicy sts_test.go:90: pol1: &{Version:STSv1 Mode:enforce MXs:[*.mail.example.com] MaxAge:34h17m36s} --- PASS: TestParsePolicy (0.00s) @@ -1588,29 +1621,29 @@ sts_test.go:242: got error as expected: MTA-STS TXT record missing --- PASS: TestPolicyTooBig (0.01s) === RUN TestCacheBasics - testlib.go:32: test directory: "/tmp/testlib_3722051759" + testlib.go:32: test directory: "/tmp/testlib_3038402847" sts_test.go:277: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:286: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:300: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:309: cache fetched domErr: ---- PASS: TestCacheBasics (0.01s) +--- PASS: TestCacheBasics (0.08s) === RUN TestCacheBadData - testlib.go:32: test directory: "/tmp/testlib_3983474295" + testlib.go:32: test directory: "/tmp/testlib_2083912692" sts_test.go:349: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:363: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:372: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:349: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:363: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:372: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} ---- PASS: TestCacheBadData (0.01s) +--- PASS: TestCacheBadData (0.14s) === RUN TestCacheRefresh - testlib.go:32: test directory: "/tmp/testlib_2509338331" + testlib.go:32: test directory: "/tmp/testlib_1243594029" sts_test.go:389: Fetch "refresh-test": &{STSv1 enforce [mx] 1m40s} sts_test.go:389: Fetch "refresh-test": &{STSv1 enforce [mx] 1m40s} sts_test.go:389: Fetch "refresh-test": &{STSv1 enforce [mx] 3m20s} ---- PASS: TestCacheRefresh (0.01s) +--- PASS: TestCacheRefresh (0.09s) === RUN TestCacheSlashSafe - testlib.go:32: test directory: "/tmp/testlib_18662129" + testlib.go:32: test directory: "/tmp/testlib_3816504029" sts_test.go:464: recovered: domain contains slash --- PASS: TestCacheSlashSafe (0.00s) === RUN TestURLForDomain @@ -1620,32 +1653,32 @@ === RUN TestHTTPGet --- PASS: TestHTTPGet (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/sts 0.049s +ok blitiri.com.ar/go/chasquid/internal/sts 0.328s === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_3801708764" + testlib.go:32: test directory: "/tmp/testlib_1647306307" --- PASS: TestBasic (0.00s) === RUN TestRemoveCheck testlib_test.go:33: recovered: invalid/dangerous directory --- PASS: TestRemoveCheck (0.00s) === RUN TestLeaveDirOnError ---- PASS: TestLeaveDirOnError (0.01s) +--- PASS: TestLeaveDirOnError (0.00s) === RUN TestRewriteSafeguard testlib_test.go:60: recovered: invalid/dangerous path --- PASS: TestRewriteSafeguard (0.00s) === RUN TestRewrite - testlib.go:32: test directory: "/tmp/testlib_1224187375" + testlib.go:32: test directory: "/tmp/testlib_2392970941" --- PASS: TestRewrite (0.00s) === RUN TestGetFreePort --- PASS: TestGetFreePort (0.00s) === RUN TestWaitFor --- PASS: TestWaitFor (0.02s) === RUN TestGenerateCert - testlib.go:32: test directory: "/tmp/testlib_3498617534" ---- PASS: TestGenerateCert (0.06s) + testlib.go:32: test directory: "/tmp/testlib_26427669" +--- PASS: TestGenerateCert (0.03s) === RUN TestGenerateCertBadDir --- PASS: TestGenerateCertBadDir (0.05s) PASS -ok blitiri.com.ar/go/chasquid/internal/testlib 0.143s +ok blitiri.com.ar/go/chasquid/internal/testlib 0.110s === RUN TestVersionName --- PASS: TestVersionName (0.00s) === RUN TestCipherSuiteName @@ -1653,34 +1686,34 @@ PASS ok blitiri.com.ar/go/chasquid/internal/tlsconst 0.005s === RUN TestEmptyLoad - userdb_test.go:37: file: "/tmp/userdb_test264721793" - userdb_test.go:37: file: "/tmp/userdb_test414870837" + userdb_test.go:37: file: "/tmp/userdb_test1576334725" + userdb_test.go:37: file: "/tmp/userdb_test219434044" --- PASS: TestEmptyLoad (0.00s) === RUN TestWrite - userdb_test.go:37: file: "/tmp/userdb_test3558803824" ---- PASS: TestWrite (0.54s) + userdb_test.go:37: file: "/tmp/userdb_test1891660203" +--- PASS: TestWrite (0.49s) === RUN TestNew ---- PASS: TestNew (0.07s) +--- PASS: TestNew (0.12s) === RUN TestInvalidUsername - userdb_test.go:37: file: "/tmp/userdb_test3560337836" + userdb_test.go:37: file: "/tmp/userdb_test3045404285" --- PASS: TestInvalidUsername (0.00s) === RUN TestPlainScheme - userdb_test.go:37: file: "/tmp/userdb_test594183806" ---- PASS: TestPlainScheme (0.00s) + userdb_test.go:37: file: "/tmp/userdb_test36767537" +--- PASS: TestPlainScheme (0.05s) === RUN TestDeniedScheme - userdb_test.go:37: file: "/tmp/userdb_test433099143" ---- PASS: TestDeniedScheme (0.01s) + userdb_test.go:37: file: "/tmp/userdb_test492581548" +--- PASS: TestDeniedScheme (0.06s) === RUN TestReload - userdb_test.go:37: file: "/tmp/userdb_test2076281702" + userdb_test.go:37: file: "/tmp/userdb_test222314976" --- PASS: TestReload (0.10s) === RUN TestRemoveUser - userdb_test.go:37: file: "/tmp/userdb_test2487473177" ---- PASS: TestRemoveUser (0.08s) + userdb_test.go:37: file: "/tmp/userdb_test2735727898" +--- PASS: TestRemoveUser (0.09s) === RUN TestExists - userdb_test.go:37: file: "/tmp/userdb_test456674334" ---- PASS: TestExists (0.08s) + userdb_test.go:37: file: "/tmp/userdb_test1466336076" +--- PASS: TestExists (0.11s) PASS -ok blitiri.com.ar/go/chasquid/internal/userdb 0.901s +ok blitiri.com.ar/go/chasquid/internal/userdb 1.027s create-stamp debian/debhelper-build-stamp dh_testroot -O--buildsystem=golang dh_prep -O--buildsystem=golang @@ -1734,8 +1767,8 @@ dpkg-gencontrol: warning: package chasquid: substitution variable ${misc:Static-Built-Using} unused, but is defined dh_md5sums -O--buildsystem=golang dh_builddeb -O--buildsystem=golang -dpkg-deb: building package 'chasquid' in '../chasquid_1.13-1_amd64.deb'. dpkg-deb: building package 'chasquid-dbgsym' in '../chasquid-dbgsym_1.13-1_amd64.deb'. +dpkg-deb: building package 'chasquid' in '../chasquid_1.13-1_amd64.deb'. dpkg-genbuildinfo --build=binary -O../chasquid_1.13-1_amd64.buildinfo dpkg-genchanges --build=binary -O../chasquid_1.13-1_amd64.changes dpkg-genchanges: info: binary-only upload (no source code included) @@ -1743,12 +1776,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: including full source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/1856390/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/1856390/tmp/hooks/B01_cleanup finished I: unmounting dev/ptmx filesystem I: unmounting dev/pts filesystem I: unmounting dev/shm filesystem I: unmounting proc filesystem I: unmounting sys filesystem I: cleaning the build env -I: removing directory /srv/workspace/pbuilder/1187562 and its subdirectories -I: Current time: Wed May 8 18:43:58 -12 2024 -I: pbuilder-time-stamp: 1715237038 +I: removing directory /srv/workspace/pbuilder/1856390 and its subdirectories +I: Current time: Thu Jun 12 03:09:21 +14 2025 +I: pbuilder-time-stamp: 1749647361