Diff of the two buildlogs: -- --- b1/build.log 2024-12-18 14:39:13.834798537 +0000 +++ b2/build.log 2024-12-18 14:45:31.745614440 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Tue Jan 20 09:00:47 -12 2026 -I: pbuilder-time-stamp: 1768942847 +I: Current time: Thu Dec 19 04:39:17 +14 2024 +I: pbuilder-time-stamp: 1734532757 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -27,52 +27,84 @@ 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/1038988/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/426711/tmp/hooks/D01_modify_environment starting +debug: Running on ionos1-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 Dec 18 14:39 /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/426711/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/426711/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' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=42 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='amd64' + 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]="37" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu") + BASH_VERSION='5.2.37(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=20 ' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=x86_64 + HOST_ARCH=amd64 IFS=' ' - INVOCATION_ID='8f21349416dc4eccb8b639c54754d513' - 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='1038988' - PS1='# ' - PS2='> ' + INVOCATION_ID=87acc25e912a4fb89f1eccc665398339 + 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=426711 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.yUDVJLfS/pbuilderrc_N7Hd --distribution trixie --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.yUDVJLfS/b1 --logfile b1/build.log chasquid_1.14.0-2.dsc' - SUDO_GID='110' - SUDO_UID='105' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://213.165.73.152:3128' + 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.yUDVJLfS/pbuilderrc_cIjI --distribution trixie --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.yUDVJLfS/b2 --logfile b2/build.log chasquid_1.14.0-2.dsc' + SUDO_GID=110 + SUDO_UID=105 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://46.16.76.132:3128 I: uname -a - Linux ionos5-amd64 6.11.5+bpo-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.11.5-1~bpo12+1 (2024-11-11) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-28-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.119-1 (2024-11-22) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Nov 22 2024 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/1038988/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Nov 22 14:40 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/426711/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: 43 http://deb.debian.org/debian trixie/main amd64 golang-blitiri-go-log-dev all 1.1.0-1 [6724 B] Get: 44 http://deb.debian.org/debian trixie/main amd64 golang-blitiri-go-spf-dev all 1.5.1-1 [37.2 kB] Get: 45 http://deb.debian.org/debian trixie/main amd64 golang-blitiri-go-systemd-dev all 1.1.0-1 [6952 B] -Fetched 73.8 MB in 1s (105 MB/s) +Fetched 73.8 MB in 7s (10.5 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 ... 19959 files and directories currently installed.) @@ -370,7 +402,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/chasquid-1.14.0/ && 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.14.0-2_source.changes +I: user script /srv/workspace/pbuilder/426711/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/426711/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/chasquid-1.14.0/ && 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.14.0-2_source.changes dpkg-buildpackage: info: source package chasquid dpkg-buildpackage: info: source version 1.14.0-2 dpkg-buildpackage: info: source distribution unstable @@ -390,259 +426,259 @@ debian/rules override_dh_auto_build make[1]: Entering directory '/build/reproducible-path/chasquid-1.14.0' dh_auto_build -- -ldflags " -X main.version=1.14.0-2 -X main.sourceDateTs=1717328439" - cd obj-x86_64-linux-gnu && go install -trimpath -v -p 42 -ldflags " -X main.version=1.14.0-2 -X main.sourceDateTs=1717328439" 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/dkim 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 -cmp + cd obj-x86_64-linux-gnu && go install -trimpath -v -p 20 -ldflags " -X main.version=1.14.0-2 -X main.sourceDateTs=1717328439" 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/dkim 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 encoding +cmp internal/unsafeheader -internal/race -internal/nettrace -internal/itoa -unicode/utf8 internal/coverage/rtcov -vendor/golang.org/x/crypto/internal/alias -blitiri.com.ar/go/chasquid/internal/set -internal/profilerecord -unicode/utf16 internal/godebugs +unicode/utf8 internal/asan -log/internal -container/list +internal/goos +internal/race +internal/profilerecord +internal/itoa +math/bits internal/byteorder -crypto/internal/alias -vendor/golang.org/x/crypto/cryptobyte/asn1 -internal/cpu internal/goarch -crypto/internal/boring/sig internal/goexperiment +sync/atomic internal/msan -google.golang.org/protobuf/internal/flags -internal/goos -math/bits -crypto/subtle +internal/cpu +internal/runtime/atomic internal/runtime/syscall unicode +internal/nettrace +container/list +google.golang.org/protobuf/internal/flags +log/internal +crypto/internal/alias +crypto/subtle +unicode/utf16 container/ring -internal/runtime/atomic -sync/atomic +vendor/golang.org/x/crypto/cryptobyte/asn1 +crypto/internal/boring/sig +vendor/golang.org/x/crypto/internal/alias +blitiri.com.ar/go/chasquid/internal/set +google.golang.org/protobuf/internal/set +internal/chacha8rand runtime/internal/math runtime/internal/sys internal/abi -internal/chacha8rand -google.golang.org/protobuf/internal/set +internal/runtime/exithook internal/bytealg math -internal/runtime/exithook internal/stringslite runtime +internal/reflectlite iter internal/weak -internal/reflectlite sync -maps slices +maps internal/bisect -internal/singleflight internal/testlog +internal/singleflight google.golang.org/protobuf/internal/pragma runtime/cgo -internal/godebug errors sort strconv -path internal/oserror io -math/rand -math/rand/v2 +path +internal/godebug +syscall vendor/golang.org/x/net/dns/dnsmessage +math/rand/v2 crypto/internal/edwards25519/field crypto/internal/nistec/fiat -syscall -internal/concurrent -golang.org/x/text/internal/tag -unique -crypto/internal/edwards25519 +strings hash -crypto/internal/randutil bytes -strings +golang.org/x/text/internal/tag +crypto/internal/randutil +math/rand hash/fnv hash/crc32 +internal/concurrent +crypto/internal/edwards25519 +unique crypto -crypto/rc4 -net/netip reflect +crypto/rc4 crypto/md5 -vendor/golang.org/x/text/transform crypto/cipher +vendor/golang.org/x/text/transform golang.org/x/text/transform -net/http/internal/ascii bufio +net/http/internal/ascii regexp/syntax html +net/netip golang.org/x/text/runes golang.org/x/text/width -crypto/des crypto/internal/boring -crypto/aes -crypto/hmac +crypto/des crypto/sha512 +crypto/aes crypto/sha1 +crypto/hmac crypto/sha256 vendor/golang.org/x/crypto/hkdf golang.org/x/crypto/pbkdf2 +regexp +time internal/syscall/execenv internal/syscall/unix -time -regexp -context io/fs +context internal/poll -embed +internal/fmtsort +encoding/binary internal/filepathlite +embed +os google.golang.org/protobuf/internal/editiondefaults crypto/internal/nistec -os -internal/fmtsort -encoding/binary -crypto/ecdh encoding/base64 -vendor/golang.org/x/crypto/chacha20 golang.org/x/crypto/scrypt +vendor/golang.org/x/crypto/chacha20 vendor/golang.org/x/crypto/internal/poly1305 golang.org/x/sys/unix encoding/pem -google.golang.org/protobuf/internal/detrand -blitiri.com.ar/go/chasquid/internal/safeio +crypto/ecdh +fmt path/filepath +google.golang.org/protobuf/internal/detrand io/ioutil +net internal/sysinfo -fmt os/signal vendor/golang.org/x/sys/cpu -vendor/golang.org/x/crypto/sha3 -vendor/golang.org/x/crypto/chacha20poly1305 +blitiri.com.ar/go/chasquid/internal/safeio os/exec -google.golang.org/protobuf/internal/version +vendor/golang.org/x/crypto/chacha20poly1305 +vendor/golang.org/x/crypto/sha3 log -net/url -encoding/hex -blitiri.com.ar/go/chasquid/internal/envelope -mime/quotedprintable -net/http/internal -google.golang.org/protobuf/internal/errors flag -runtime/trace +google.golang.org/protobuf/internal/version text/template/parse +google.golang.org/protobuf/internal/errors +encoding/hex go/token -runtime/debug -text/tabwriter -encoding/json -blitiri.com.ar/go/chasquid/internal/tlsconst compress/flate +net/url +encoding/json +mime/quotedprintable +net/http/internal mime +vendor/golang.org/x/text/unicode/norm vendor/golang.org/x/net/http2/hpack -golang.org/x/text/internal/language -golang.org/x/text/unicode/norm +blitiri.com.ar/go/chasquid/internal/envelope math/big -vendor/golang.org/x/text/unicode/norm +golang.org/x/text/unicode/norm +golang.org/x/text/internal/language google.golang.org/protobuf/encoding/protowire -google.golang.org/protobuf/reflect/protoreflect -golang.org/x/text/unicode/bidi +blitiri.com.ar/go/chasquid/internal/tlsconst +text/tabwriter +runtime/trace +runtime/debug vendor/golang.org/x/text/unicode/bidi +golang.org/x/text/unicode/bidi +google.golang.org/protobuf/reflect/protoreflect +golang.org/x/text/internal/language/compact +vendor/golang.org/x/text/secure/bidirule testing compress/gzip +golang.org/x/text/language +golang.org/x/term +golang.org/x/text/secure/bidirule internal/profile runtime/pprof -net -vendor/golang.org/x/text/secure/bidirule google.golang.org/protobuf/internal/encoding/messageset google.golang.org/protobuf/internal/strs -google.golang.org/protobuf/runtime/protoiface +text/template google.golang.org/protobuf/internal/order +google.golang.org/protobuf/internal/genid +google.golang.org/protobuf/runtime/protoiface google.golang.org/protobuf/internal/descfmt google.golang.org/protobuf/internal/descopts -google.golang.org/protobuf/internal/genid -text/template -golang.org/x/text/internal/language/compact -golang.org/x/text/secure/bidirule google.golang.org/protobuf/reflect/protoregistry -google.golang.org/protobuf/internal/encoding/text golang.org/x/net/idna +google.golang.org/protobuf/internal/encoding/text +golang.org/x/text/internal +golang.org/x/text/cases vendor/golang.org/x/net/idna -golang.org/x/text/language google.golang.org/protobuf/proto -google.golang.org/protobuf/internal/encoding/defval crypto/rand -crypto/internal/boring/bbig crypto/elliptic crypto/internal/bigmod -encoding/asn1 +crypto/internal/boring/bbig crypto/dsa -golang.org/x/term +encoding/asn1 +google.golang.org/protobuf/internal/encoding/defval +crypto/ed25519 crypto/internal/hpke crypto/internal/mlkem768 -crypto/ed25519 -golang.org/x/text/internal crypto/rsa -golang.org/x/text/cases -html/template +golang.org/x/text/secure/precis google.golang.org/protobuf/encoding/prototext google.golang.org/protobuf/internal/filedesc -crypto/x509/pkix vendor/golang.org/x/crypto/cryptobyte -golang.org/x/text/secure/precis -blitiri.com.ar/go/chasquid/internal/protoio -crypto/ecdsa +crypto/x509/pkix +html/template blitiri.com.ar/go/chasquid/internal/normalize +crypto/ecdsa +blitiri.com.ar/go/chasquid/internal/protoio google.golang.org/protobuf/internal/encoding/tag google.golang.org/protobuf/internal/impl -google.golang.org/protobuf/internal/filetype -google.golang.org/protobuf/runtime/protoimpl -blitiri.com.ar/go/chasquid/internal/protoio/testpb -blitiri.com.ar/go/chasquid/internal/userdb log/syslog -vendor/golang.org/x/net/http/httpproxy -blitiri.com.ar/go/chasquid/internal/haproxy -blitiri.com.ar/go/systemd net/textproto +vendor/golang.org/x/net/http/httpproxy crypto/x509 +blitiri.com.ar/go/chasquid/internal/haproxy blitiri.com.ar/go/spf +blitiri.com.ar/go/systemd 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 net/mail -blitiri.com.ar/go/chasquid/cmd/mda-lmtp mime/multipart +blitiri.com.ar/go/chasquid/cmd/mda-lmtp blitiri.com.ar/go/chasquid/internal/dkim crypto/tls +google.golang.org/protobuf/internal/filetype +google.golang.org/protobuf/runtime/protoimpl +blitiri.com.ar/go/chasquid/internal/config +blitiri.com.ar/go/chasquid/internal/userdb +blitiri.com.ar/go/chasquid/internal/protoio/testpb net/http/httptrace -blitiri.com.ar/go/chasquid/internal/testlib net/smtp +blitiri.com.ar/go/chasquid/internal/testlib net/http blitiri.com.ar/go/chasquid/internal/smtp -golang.org/x/net/context/ctxhttp expvar +golang.org/x/net/context/ctxhttp net/http/pprof blitiri.com.ar/go/chasquid/internal/nettrace -blitiri.com.ar/go/chasquid/internal/expvarom blitiri.com.ar/go/chasquid/internal/trace -blitiri.com.ar/go/chasquid/internal/localrpc -blitiri.com.ar/go/chasquid/internal/auth +blitiri.com.ar/go/chasquid/internal/expvarom blitiri.com.ar/go/chasquid/internal/domaininfo +blitiri.com.ar/go/chasquid/internal/localrpc blitiri.com.ar/go/chasquid/internal/maillog +blitiri.com.ar/go/chasquid/internal/auth +blitiri.com.ar/go/chasquid/cmd/chasquid-util blitiri.com.ar/go/chasquid/internal/sts blitiri.com.ar/go/chasquid/internal/aliases -blitiri.com.ar/go/chasquid/cmd/chasquid-util -blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/courier +blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/queue blitiri.com.ar/go/chasquid/internal/smtpsrv blitiri.com.ar/go/chasquid make[1]: Leaving directory '/build/reproducible-path/chasquid-1.14.0' dh_auto_test -O--buildsystem=golang - cd obj-x86_64-linux-gnu && go test -vet=off -v -p 42 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/dkim 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 + cd obj-x86_64-linux-gnu && go test -vet=off -v -p 20 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/dkim 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 ? blitiri.com.ar/go/chasquid [no test files] ? blitiri.com.ar/go/chasquid/cmd/chasquid-util [no test files] ? blitiri.com.ar/go/chasquid/cmd/mda-lmtp [no test files] @@ -666,7 +702,7 @@ === RUN TestTooMuchRecursionOnCatchAll --- PASS: TestTooMuchRecursionOnCatchAll (0.00s) === RUN TestAddFile ---- PASS: TestAddFile (0.00s) +--- PASS: TestAddFile (0.03s) === RUN TestRichFile --- PASS: TestRichFile (0.00s) === RUN TestManyFiles @@ -676,7 +712,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.08s) === RUN FuzzReader === RUN FuzzReader/seed#0 === RUN FuzzReader/1c24d2215db69748c6fd16797673ad11ebc7e6167fe1bc1f54c6959ec10407b6 @@ -684,16 +720,15 @@ === RUN FuzzReader/8234d8c5719f30e50525290db70743bf97d940e60591cf4a638c72158d35504a === RUN FuzzReader/c9c80ba9f513841cb081fe9bb7439d36f9f7a06bb999d4c39441991ccc878a9e === RUN FuzzReader/d40a98862ed393eb712e47a91bcef18e6f24cf368bb4bd248c7a7101ef8e178d ---- PASS: FuzzReader (0.00s) +--- PASS: FuzzReader (0.02s) --- PASS: FuzzReader/seed#0 (0.00s) - --- PASS: FuzzReader/1c24d2215db69748c6fd16797673ad11ebc7e6167fe1bc1f54c6959ec10407b6 (0.00s) - --- PASS: FuzzReader/4adaceaa32e2b32c00322948769d62c2dd42e1d9f4950d3c5b411c710e6d4a86 (0.00s) + --- PASS: FuzzReader/1c24d2215db69748c6fd16797673ad11ebc7e6167fe1bc1f54c6959ec10407b6 (0.01s) + --- PASS: FuzzReader/4adaceaa32e2b32c00322948769d62c2dd42e1d9f4950d3c5b411c710e6d4a86 (0.01s) --- PASS: FuzzReader/8234d8c5719f30e50525290db70743bf97d940e60591cf4a638c72158d35504a (0.00s) --- PASS: FuzzReader/c9c80ba9f513841cb081fe9bb7439d36f9f7a06bb999d4c39441991ccc878a9e (0.00s) --- PASS: FuzzReader/d40a98862ed393eb712e47a91bcef18e6f24cf368bb4bd248c7a7101ef8e178d (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/aliases 0.019s -? blitiri.com.ar/go/chasquid/internal/protoio/testpb [no test files] +ok blitiri.com.ar/go/chasquid/internal/aliases 0.252s === 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 @@ -706,11 +741,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.35s) +--- PASS: TestAuthenticate (0.94s) === RUN TestInterfaces --- PASS: TestInterfaces (0.00s) === RUN TestMultipleBackends ---- PASS: TestMultipleBackends (0.18s) +--- PASS: TestMultipleBackends (0.19s) === RUN TestErrors --- PASS: TestErrors (0.00s) === RUN TestReload @@ -739,46 +774,46 @@ --- PASS: FuzzDecodeResponse/d9aa9c617d1f5b3021aca758b9d896d136e3b16ed53233d02abffd02aa73ffa4 (0.00s) --- PASS: FuzzDecodeResponse/de05c7993312bab83e8114e9d9ced331c49822dc55c1a353f1cc9718a28226e7 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/auth 0.545s +ok blitiri.com.ar/go/chasquid/internal/auth 1.359s === RUN TestEmptyStruct --- PASS: TestEmptyStruct (0.00s) === RUN TestEmptyConfig - testlib.go:32: test directory: "/tmp/testlib_468584764" ---- PASS: TestEmptyConfig (0.00s) + testlib.go:32: test directory: "/tmp/testlib_2874825146" +--- PASS: TestEmptyConfig (0.15s) === RUN TestFullConfig - testlib.go:32: test directory: "/tmp/testlib_3308373304" ---- PASS: TestFullConfig (0.00s) + testlib.go:32: test directory: "/tmp/testlib_3955236354" +--- PASS: TestFullConfig (0.01s) === RUN TestErrorLoading --- PASS: TestErrorLoading (0.00s) === RUN TestBrokenConfig - testlib.go:32: test directory: "/tmp/testlib_1482052689" + testlib.go:32: test directory: "/tmp/testlib_4046850587" --- PASS: TestBrokenConfig (0.00s) === RUN TestBrokenOverride - testlib.go:32: test directory: "/tmp/testlib_1454511693" + testlib.go:32: test directory: "/tmp/testlib_618211280" --- PASS: TestBrokenOverride (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/config 0.010s -? blitiri.com.ar/go/chasquid/internal/trace [no test files] +ok blitiri.com.ar/go/chasquid/internal/config 0.224s +? blitiri.com.ar/go/chasquid/internal/protoio/testpb [no test files] === RUN TestMDA - testlib.go:32: test directory: "/tmp/testlib_1765069582" ---- PASS: TestMDA (0.00s) + testlib.go:32: test directory: "/tmp/testlib_3432004763" +--- PASS: TestMDA (0.03s) === RUN TestMDATimeout _ mda.go:73 Courier.MDA to@local: error: operation timed out ---- PASS: TestMDATimeout (0.10s) +--- PASS: TestMDATimeout (0.12s) === RUN TestMDABadCommandLine _ mda.go:86 Courier.MDA to: error: MDA delivery failed: exec: \"thisdoesnotexist\": executable file not found in $PATH - \"\" _ mda.go:86 Courier.MDA to: error: MDA delivery failed: exit status 1 - \"cat: unrecognized option '--fail_unknown_option'\\nTry 'cat --help' for more information.\\n\" ---- PASS: TestMDABadCommandLine (0.00s) +--- PASS: TestMDABadCommandLine (0.02s) === RUN TestExitCode mda_test.go:71: util/exitcode not found, running from outside repo? --- SKIP: TestExitCode (0.00s) === RUN TestSanitize --- PASS: TestSanitize (0.00s) === RUN TestSMTP - testlib.go:32: test directory: "/tmp/testlib_3868075562" - testlib.go:32: test directory: "/tmp/testlib_946960038" -_ smtp.go:127 Courier.SMTP to@to: error: Could not dial: dial tcp: address ::::45533: too many colons in address -_ smtp.go:101 Courier.SMTP to@to: error: \":::\" returned transient error: Could not dial: dial tcp: address ::::45533: too many colons in address + testlib.go:32: test directory: "/tmp/testlib_908994883" + testlib.go:32: test directory: "/tmp/testlib_1062453407" +_ smtp.go:127 Courier.SMTP to@to: error: Could not dial: dial tcp: address ::::43523: too many colons in address +_ smtp.go:101 Courier.SMTP to@to: error: \":::\" returned transient error: Could not dial: dial tcp: address ::::43523: 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:" @@ -786,26 +821,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.02s) +--- PASS: TestSMTP (0.13s) === RUN TestSMTPErrors - testlib.go:32: test directory: "/tmp/testlib_3582804238" - testlib.go:32: test directory: "/tmp/testlib_2054730325" + testlib.go:32: test directory: "/tmp/testlib_2911011597" + testlib.go:32: test directory: "/tmp/testlib_3359651848" fakeserver_test.go:98: fakeServer got connection -_ smtp.go:138 Courier.SMTP to@to: error: Error saying hello: write tcp 127.0.0.1:35666->127.0.0.1:35641: 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:35666->127.0.0.1:35641: 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:35666->127.0.0.1:35641: i/o timeout) +_ smtp.go:138 Courier.SMTP to@to: error: Error saying hello: write tcp 127.0.0.1:50150->127.0.0.1:36521: 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:50150->127.0.0.1:36521: 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:50150->127.0.0.1:36521: 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:50150->127.0.0.1:36521: i/o timeout) fakeserver_test.go:105: fakeServer exiting: EOF - smtp_test.go:140: failed as expected: all MXs returned transient failures (last: Error saying hello: write tcp 127.0.0.1:35666->127.0.0.1:35641: i/o timeout) - testlib.go:32: test directory: "/tmp/testlib_1077566789" - testlib.go:32: test directory: "/tmp/testlib_1978669694" + testlib.go:32: test directory: "/tmp/testlib_1257881183" + testlib.go:32: test directory: "/tmp/testlib_2927173100" 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_363190986" - testlib.go:32: test directory: "/tmp/testlib_1057558638" + testlib.go:32: test directory: "/tmp/testlib_2244629426" + testlib.go:32: test directory: "/tmp/testlib_854218709" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -813,8 +848,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_3365445750" - testlib.go:32: test directory: "/tmp/testlib_3193105739" + testlib.go:32: test directory: "/tmp/testlib_1348888610" + testlib.go:32: test directory: "/tmp/testlib_1745366156" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -823,8 +858,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_537348149" - testlib.go:32: test directory: "/tmp/testlib_1664209833" + testlib.go:32: test directory: "/tmp/testlib_3568648873" + testlib.go:32: test directory: "/tmp/testlib_2559747280" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -833,9 +868,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.21s) +--- PASS: TestSMTPErrors (1.52s) === RUN TestNoMXServer - testlib.go:32: test directory: "/tmp/testlib_3349367313" + testlib.go:32: test directory: "/tmp/testlib_1740416440" _ 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) @@ -850,8 +885,8 @@ === RUN TestLookupInvalidDomain --- PASS: TestLookupInvalidDomain (0.00s) === RUN TestTLS - testlib.go:32: test directory: "/tmp/testlib_2113176320" - testlib.go:32: test directory: "/tmp/testlib_2246885463" + testlib.go:32: test directory: "/tmp/testlib_3775081328" + testlib.go:32: test directory: "/tmp/testlib_4245335698" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -862,34 +897,34 @@ 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_170956810" + testlib.go:32: test directory: "/tmp/testlib_427593272" 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 _ smtp.go:185 Courier.SMTP to@to: error: Security level check failed (level:PLAIN) _ smtp.go:101 Courier.SMTP to@to: error: \"localhost\" returned transient error: Security level check failed (level:PLAIN) - fakeserver_test.go:105: fakeServer exiting: EOF _ smtp.go:105 Courier.SMTP to@to: error: all MXs returned transient failures (last: Security level check failed (level:PLAIN)) ---- PASS: TestTLS (0.10s) + fakeserver_test.go:105: fakeServer exiting: EOF +--- PASS: TestTLS (0.19s) === RUN TestTLSError - testlib.go:32: test directory: "/tmp/testlib_3094468086" - testlib.go:32: test directory: "/tmp/testlib_1226490256" + testlib.go:32: test directory: "/tmp/testlib_885439598" + testlib.go:32: test directory: "/tmp/testlib_3828465234" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" _ smtp.go:171 Courier.SMTP to@to: error: TLS error, retrying without TLS: 500 starttls err - fakeserver_test.go:105: fakeServer exiting: EOF fakeserver_test.go:98: fakeServer got connection + fakeserver_test.go:105: fakeServer exiting: EOF fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" fakeserver_test.go:109: fakeServer read: "RCPT TO:" fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestTLSError (0.02s) +--- PASS: TestTLSError (0.10s) === RUN TestSTSPolicyEnforcement - testlib.go:32: test directory: "/tmp/testlib_1020743403" - testlib.go:32: test directory: "/tmp/testlib_698124472" + testlib.go:32: test directory: "/tmp/testlib_3084600610" + testlib.go:32: test directory: "/tmp/testlib_1797397612" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -897,7 +932,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_1148035899" + testlib.go:32: test directory: "/tmp/testlib_3463288056" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -908,9 +943,9 @@ fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestSTSPolicyEnforcement (0.04s) +--- PASS: TestSTSPolicyEnforcement (0.65s) PASS -ok blitiri.com.ar/go/chasquid/internal/courier 1.507s +ok blitiri.com.ar/go/chasquid/internal/courier 2.805s === RUN TestStringToCanonicalization --- PASS: TestStringToCanonicalization (0.00s) === RUN TestSimpleBody @@ -946,7 +981,7 @@ file_test.go:50: Loaded DNS results: map[string][]string{"brisbane._domainkey.football.example.com":[]string{" v=DKIM1; k=ed25519; p=11qYAYKxCrfVS/7TyWQHOg7hcvPapiMlrwIaaPcHURo="}, "test._domainkey.football.example.com":[]string{" v=DKIM1; k=rsa; p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDkHlOQoBTzWRiGs5V6NpP3idY6Wk08a5qhdR6wy5bdOKb2jLQiY/J16JYi0Qvx/byYzCNb3W91y3FutACDfzwQ/BC/e/8uBsCR+yz1Lxj+PL6lHvqMKrM3rG4hstT5QjvHO9PzoxZyVYLzBfO2EeC3Ip3G+2kryOTIKT+l/K4w3QIDAQAB"}} file_test.go:50: Loaded DNS errors: map[] file_test.go:55: Message: "DKIM-Signature: v=1; a=ed25519-sha256; c=relaxed/relaxed;\r\n " - file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0xc00026fe00 0xc00026fe60]} + file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0xc00023fe00 0xc00023fe60]} file_test.go:57: Want error: context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; d=football.example.com; i=@football.example.com; @@ -990,7 +1025,7 @@ file_test.go:50: Loaded DNS results: map[string][]string{"brisbane._domainkey.football.example.com":[]string{" v=DKIM1; k=ed25519; p=11qYAYKxCrfVS/7TyWQHOg7hcvPapiMlrwIaaPcHURo="}, "test._domainkey.football.example.com":[]string{" v=DKIM1; k=rsa; p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDkHlOQoBTzWRiGs5V6NpP3idY6Wk08a5qhdR6wy5bdOKb2jLQiY/J16JYi0Qvx/byYzCNb3W91y3FutACDfzwQ/BC/e/8uBsCR+yz1Lxj+PL6lHvqMKrM3rG4hstT5QjvHO9PzoxZyVYLzBfO2EeC3Ip3G+2kryOTIKT+l/K4w3QIDAQAB"}} file_test.go:50: Loaded DNS errors: map[] file_test.go:55: Message: "DKIM-Signature: v=1; a=ed25519-sha256; c=relaxed/relaxed;\r\n " - file_test.go:56: Want result: &{Found:5 Valid:5 Results:[0xc00029c6c0 0xc00029c720 0xc00029c780 0xc00029c7e0 0xc00029c840]} + file_test.go:56: Want result: &{Found:5 Valid:5 Results:[0xc00026c6c0 0xc00026c720 0xc00026c780 0xc00026c7e0 0xc00026c840]} file_test.go:57: Want error: context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; d=football.example.com; i=@football.example.com; @@ -1102,7 +1137,7 @@ file_test.go:50: Loaded DNS results: map[string][]string{} file_test.go:50: Loaded DNS errors: map[] file_test.go:55: Message: "DKIM-Signature: v=8; a=ed25519-sha256; c=relaxed/relaxed;\r\n " - file_test.go:56: Want result: &{Found:1 Valid:0 Results:[0xc00029d440]} + file_test.go:56: Want result: &{Found:1 Valid:0 Results:[0xc00026d440]} file_test.go:57: Want error: context.go:17: Found DKIM-Signature header: v=8; a=ed25519-sha256; c=relaxed/relaxed; d=football.example.com; i=@football.example.com; @@ -1116,7 +1151,7 @@ file_test.go:50: Loaded DNS results: map[string][]string{"test._domainkey.football.example.com":[]string{" v=DKIM1; k=rsa; p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDkHlOQoBTzWRiGs5V6NpP3idY6Wk08a5qhdR6wy5bdOKb2jLQiY/J16JYi0Qvx/byYzCNb3W91y3FutACDfzwQ/BC/e/8uBsCR+yz1Lxj+PL6lHvqMKrM3rG4hstT5QjvHO9PzoxZyVYLzBfO2EeC3Ip3G+2kryOTIKT+l/K4w3QIDAQAB"}} file_test.go:50: Loaded DNS errors: map[brisbane._domainkey.football.example.com:lookup : temporary error (for testing)] file_test.go:55: Message: "DKIM-Signature: v=1; a=ed25519-sha256; c=relaxed/relaxed;\r\n " - file_test.go:56: Want result: &{Found:2 Valid:1 Results:[0xc00029d860 0xc00029d8c0]} + file_test.go:56: Want result: &{Found:2 Valid:1 Results:[0xc00026d860 0xc00026d8c0]} file_test.go:57: Want error: context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; d=football.example.com; i=@football.example.com; @@ -1150,7 +1185,7 @@ file_test.go:50: Loaded DNS results: map[string][]string{"test._domainkey.football.example.com":[]string{" v=DKIM1; k=rsa; p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDkHlOQoBTzWRiGs5V6NpP3idY6Wk08a5qhdR6wy5bdOKb2jLQiY/J16JYi0Qvx/byYzCNb3W91y3FutACDfzwQ/BC/e/8uBsCR+yz1Lxj+PL6lHvqMKrM3rG4hstT5QjvHO9PzoxZyVYLzBfO2EeC3Ip3G+2kryOTIKT+l/K4w3QIDAQAB"}} file_test.go:50: Loaded DNS errors: map[brisbane._domainkey.football.example.com:lookup : permanent error (for testing)] file_test.go:55: Message: "DKIM-Signature: v=1; a=ed25519-sha256; c=relaxed/relaxed;\r\n " - file_test.go:56: Want result: &{Found:2 Valid:1 Results:[0xc00029dec0 0xc00029df20]} + file_test.go:56: Want result: &{Found:2 Valid:1 Results:[0xc00026dec0 0xc00026df20]} file_test.go:57: Want error: context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; d=football.example.com; i=@football.example.com; @@ -1184,7 +1219,7 @@ file_test.go:50: Loaded DNS results: map[string][]string{"brisbane._domainkey.football.example.com":[]string{" v=DKIM1; k=rsa; p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDkHlOQoBTzWRiGs5V6NpP3idY6Wk08a5qhdR6wy5bdOKb2jLQiY/J16JYi0Qvx/byYzCNb3W91y3FutACDfzwQ/BC/e/8uBsCR+yz1Lxj+PL6lHvqMKrM3rG4hstT5QjvHO9PzoxZyVYLzBfO2EeC3Ip3G+2kryOTIKT+l/K4w3QIDAQAB", " v=DKIM1; k=ed25519; p=11qYAYKxCrfVS/7TyWQHOg7hcvPapiMlrwIaaPcHURo="}, "test._domainkey.football.example.com":[]string{" v=DKIM1; k=rsa; p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDkHlOQoBTzWRiGs5V6NpP3idY6Wk08a5qhdR6wy5bdOKb2jLQiY/J16JYi0Qvx/byYzCNb3W91y3FutACDfzwQ/BC/e/8uBsCR+yz1Lxj+PL6lHvqMKrM3rG4hstT5QjvHO9PzoxZyVYLzBfO2EeC3Ip3G+2kryOTIKT+l/K4w3QIDAQAB"}} file_test.go:50: Loaded DNS errors: map[] file_test.go:55: Message: "DKIM-Signature: v=1; a=ed25519-sha256; c=relaxed/relaxed;\r\n " - file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0xc000304600 0xc000304660]} + file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0xc000352600 0xc000352660]} file_test.go:57: Want error: context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; d=football.example.com; i=@football.example.com; @@ -1231,7 +1266,7 @@ file_test.go:50: Loaded DNS results: map[string][]string{"brisbane._domainkey.football.example.com":[]string{" v=DKIM1; k=ed25519; p=11qYAYKxCrfVS/7TyWQHOg7hcvPapiMlrwIaaPcHURo="}, "selector._domainkey.example.com":[]string{" v=DKIM1; k=ed25519; p=SvoPT692bVrQBT8UNxt6SF538O3snA4fE3/i/glCxwQ="}, "test._domainkey.football.example.com":[]string{" v=DKIM1; k=rsa; p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDkHlOQoBTzWRiGs5V6NpP3idY6Wk08a5qhdR6wy5bdOKb2jLQiY/J16JYi0Qvx/byYzCNb3W91y3FutACDfzwQ/BC/e/8uBsCR+yz1Lxj+PL6lHvqMKrM3rG4hstT5QjvHO9PzoxZyVYLzBfO2EeC3Ip3G+2kryOTIKT+l/K4w3QIDAQAB"}} file_test.go:50: Loaded DNS errors: map[] file_test.go:55: Message: "DKIM-Signature: v=1; a=ed25519-sha256; c=relaxed/relaxed;\r\n " - file_test.go:56: Want result: &{Found:3 Valid:3 Results:[0xc000304d80 0xc000304de0 0xc000304e40]} + file_test.go:56: Want result: &{Found:3 Valid:3 Results:[0xc000352d80 0xc000352de0 0xc000352e40]} file_test.go:57: Want error: context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=selector; t=1709341950; @@ -1291,7 +1326,7 @@ file_test.go:50: Loaded DNS results: map[string][]string{"brisbane._domainkey.football.example.com":[]string{" v=DKIM1; k=ed25519; p=11qYAYKxCrfVS/7TyWQHOg7hcvPapiMlrwIaaPcHURo="}, "selector._domainkey.example.com":[]string{" v=DKIM1; k=ed25519; p=SvoPT692bVrQBT8UNxt6SF538O3snA4fE3/i/glCxwQ="}, "test._domainkey.football.example.com":[]string{" v=DKIM1; k=rsa; p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDkHlOQoBTzWRiGs5V6NpP3idY6Wk08a5qhdR6wy5bdOKb2jLQiY/J16JYi0Qvx/byYzCNb3W91y3FutACDfzwQ/BC/e/8uBsCR+yz1Lxj+PL6lHvqMKrM3rG4hstT5QjvHO9PzoxZyVYLzBfO2EeC3Ip3G+2kryOTIKT+l/K4w3QIDAQAB"}} file_test.go:50: Loaded DNS errors: map[] file_test.go:55: Message: "DKIM-Signature: v=1; a=ed25519-sha256; c=relaxed/relaxed;\r\n " - file_test.go:56: Want result: &{Found:3 Valid:3 Results:[0xc000305620 0xc000305680 0xc0003056e0]} + file_test.go:56: Want result: &{Found:3 Valid:3 Results:[0xc000353620 0xc000353680 0xc0003536e0]} file_test.go:57: Want error: context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=selector; t=1709368031; @@ -1351,7 +1386,7 @@ file_test.go:50: Loaded DNS results: map[string][]string{"brisbane._domainkey.football.example.com":[]string{" v=DKIM1; k=ed25519; t=s; p=11qYAYKxCrfVS/7TyWQHOg7hcvPapiMlrwIaaPcHURo="}, "test._domainkey.football.example.com":[]string{" v=DKIM1; k=rsa; t=s; p=MIGfMA0GCSqGSIb3DQEBAQUAA4GNADCBiQKBgQDkHlOQoBTzWRiGs5V6NpP3idY6Wk08a5qhdR6wy5bdOKb2jLQiY/J16JYi0Qvx/byYzCNb3W91y3FutACDfzwQ/BC/e/8uBsCR+yz1Lxj+PL6lHvqMKrM3rG4hstT5QjvHO9PzoxZyVYLzBfO2EeC3Ip3G+2kryOTIKT+l/K4w3QIDAQAB"}} file_test.go:50: Loaded DNS errors: map[] file_test.go:55: Message: "DKIM-Signature: v=1; a=ed25519-sha256; c=relaxed/relaxed;\r\n " - file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0xc000305f20 0xc000376000]} + file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0xc000353f20 0xc0003c4000]} file_test.go:57: Want error: context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; d=football.example.com; i=@football.example.com; @@ -1397,7 +1432,7 @@ file_test.go:50: Loaded DNS results: map[string][]string{"selector._domainkey.example.com":[]string{" v=DKIM1; k=ed25519; t=s; p=SvoPT692bVrQBT8UNxt6SF538O3snA4fE3/i/glCxwQ="}} file_test.go:50: Loaded DNS errors: map[] file_test.go:55: Message: "DKIM-Signature: v=1; a=ed25519-sha256; c=relaxed/relaxed;\r\n " - file_test.go:56: Want result: &{Found:1 Valid:0 Results:[0xc0003766c0]} + file_test.go:56: Want result: &{Found:1 Valid:0 Results:[0xc0003c46c0]} file_test.go:57: Want error: context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=selector; t=1709466347; @@ -1418,7 +1453,7 @@ context.go:17: Resulting hash: "kFTkVTyR9JWKX/Stl1+sUIuAgitRiOf7MwTBy5a2/ZA=" context.go:17: PK [ed25519:4afa0f4faf766d5a]: Strict domain check failed: "example.com" != "sub.example.com" ("test@sub.example.com") context.go:17: Found 1 signatures, 0 valid ---- PASS: TestFromFiles (0.01s) +--- PASS: TestFromFiles (0.02s) --- PASS: TestFromFiles/testdata/01-rfc8463 (0.00s) --- PASS: TestFromFiles/testdata/02-too_many_headers (0.00s) --- PASS: TestFromFiles/testdata/03-bad_message (0.00s) @@ -1453,18 +1488,18 @@ context.go:17: Hashing header: "date:Fri, 11 Jul 2003 21:00:37 -0700 (PDT)\r\n" context.go:17: Hashing header: "to:Suzie Q \r\n" context.go:17: Hashing header: "message-id:<20030712040037.46341.5F8J@football.example.com>\r\n" - context.go:17: Hashing header: "dkim-signature:v=1; a=rsa-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1768942910; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "RmTK/WGDNElga//J/kD8lFG8FuIss4Wrhgi1zhFu2EM=" + context.go:17: Hashing header: "dkim-signature:v=1; a=rsa-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1734533054; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "TTSeB4E9gtKpRtKaMNC4uK4q/RRjeSThhbSra0BNa14=" context.go:17: Found DKIM-Signature header: v=1; a=rsa-sha256; c=relaxed/relaxed; - d=example.com; s=test; t=1768942910; + d=example.com; s=test; t=1734533054; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; - b=QHyZPXCqv+7E5nAHa8mQfSDULH5ASUFxuTmkPsbb1F8CLUfKgYPSHzI3hkCSlPw7zjpgJC - iJ+ZCy8gq41tdDVte/pWbGrKJB6IjACsd7InoFR3IvGYD+SiGqS4RN3EHHXtPVSqsoe3SE - qaUx2tFaT1oXxBwq0IVJLDlIiCvIk8Fbfl6goOL35bAcJc3JFsSLb9jyNyRRn/ILI2I/LL - /BtcmXTReD/3AL0BWJFli4059AixPvZU6tZpVMIG3RuPdCd5940Eas9JYQcfogE3hnPUmu - NH6/wJnh8gteaSV5o3cZmJsYpcisqebxead38qIoYD9SfoGWZCCDGFhpcNiNKg==; - context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; p=MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAzkO6rTdTZYCFVEiWnj3Eiy6sMBlgnztN0B5FlPs9h3PirGkJvzZdghjRRZSm2zHc6pFiYCHcz/t09fgA8q0Hke++8klklrzI8mUUSP6zuh1aXy9YGVu5cXd9rU3dyRpiUPaIcrFmISrLwKhy5HfbRcuHOSsQh67mLXmtx/CN8iN3KxdgsfXdOrWgHL1GM5q6LneoomzkZ5YbZKmKH8lQ06CqUaK0SKd78A/BeRvSDM5ok3lpH0kKvHGiBFeOZJqK+NkCQp+6dtySaotvAlOwRgzQjaXjG9nv8sk3ivl7vXlOxKWKKIJzfHEOHoHAXVvmSNGmcpaAym0A6fyL+PVtTwIDAQAB" + b=LBb4ST2hwaglMEU8YyLkOjT9Oirevq7cnBEJxapaR0KEKQtn1eJp/XOMgECrCPunvIRTm3 + o/o0SbEzki04W+S70bQDn9SWlAQmqI7carG3BtkJJDENvCc3mrH6a3Rv5ZNmRM1inNP3Xw + 6qMxyouPLl9S7OGHMu/fR/ZyJ2aOwuJYPSvKHv5FCx6GWjE0N8mKU1AVV/lasPFfQwzzgc + XBBvr2QaxbRcsH0v9l0KlsWcXqN620vsoI8omaDeqOBGKjf4V+1FndW3sxWU8KUMQ6LuuC + 59Nkqn0Iund3VHatQdBEAB5S2g7WSxhy3WWwn1LOCSznKxH1XuS9KKJZRl/S/Q==; + context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; p=MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAnooheAbqBrH9pTxX6BPleanZ6ZDdFEYbVw2KNmiXXDM99CovLYLz9kDVrmOcXgyh+GUtgKNp5nnaRYu0bHpHbnsBQ3GyR9njm5PtqJZFkvFz9Xc2lNys+QD/5DQoL6VTWOK2JY/RNaLRhWC4Pp0og6UFuaHMWau5hmWn8Ko8PTAHMlY+a9LTnZvvUH22hs4kY9ue3AEvtRg8cjOxxq9FrRlYB16Uhl1Wj2ni6Pbh4hK6zx60gd93CGr0CmmXnOrYLx/c/4Dbv9FoHn3lj+4zZs+q7BwQLwm7Yo64FZVXJL1imF01+/NGQVWRCgZ/ocONp3jwrTExSZBtb/VtHsZaQwIDAQAB" context.go:17: Parsed public key: [rsa:30820122300d0609] context.go:17: Body hash matches: "2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=" context.go:17: Hashing header: "from:Joe SixPack \r\n" @@ -1472,11 +1507,11 @@ context.go:17: Hashing header: "date:Fri, 11 Jul 2003 21:00:37 -0700 (PDT)\r\n" context.go:17: Hashing header: "to:Suzie Q \r\n" context.go:17: Hashing header: "message-id:<20030712040037.46341.5F8J@football.example.com>\r\n" - context.go:17: Hashing header: "dkim-signature:v=1; a=rsa-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1768942910; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "RmTK/WGDNElga//J/kD8lFG8FuIss4Wrhgi1zhFu2EM=" + context.go:17: Hashing header: "dkim-signature:v=1; a=rsa-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1734533054; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "TTSeB4E9gtKpRtKaMNC4uK4q/RRjeSThhbSra0BNa14=" context.go:17: PK [rsa:30820122300d0609]: Verification succeeded context.go:17: Found 1 signatures, 1 valid ---- PASS: TestSignRSA (0.26s) +--- PASS: TestSignRSA (0.61s) === RUN TestSignEd25519 context.go:17: Signing for example.com / test with ed25519-sha256 context.go:17: Hashing header: "from:Joe SixPack \r\n" @@ -1484,27 +1519,27 @@ context.go:17: Hashing header: "date:Fri, 11 Jul 2003 21:00:37 -0700 (PDT)\r\n" context.go:17: Hashing header: "to:Suzie Q \r\n" context.go:17: Hashing header: "message-id:<20030712040037.46341.5F8J@football.example.com>\r\n" - context.go:17: Hashing header: "dkim-signature:v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1768942910; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "oCf54A7ebD8v7ZT7A+9NtocwWwVSwIlFCKdHJezoudw=" + context.go:17: Hashing header: "dkim-signature:v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1734533054; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "QNu1YVWiO5c/BqoSHbKNEgs77sPgyRli9E3FrACThxA=" context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; - d=example.com; s=test; t=1768942910; + d=example.com; s=test; t=1734533054; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; - b=2u3rNt4090wr5Tz79VQSASfwmJkPL16osRn4xLD2BDghHWAUP9p1wlaKe7khkiabO+z8at - X36HUFp0kEGHK+BQ==; - context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; k=ed25519; p=SjFZx1pj/JwaVbvKSOXX2mHO4jj/qKS2qngp8Wwx9T4=" - context.go:17: Parsed public key: [ed25519:4a3159c75a63fc9c] + b=aiUUaMaMuT6suFH5QGg859yTxrR42YPHmK/iKDa9XoKzhe0TK3O6Mryw6ePAmnulebv9rA + xANpgQayOQQ5pRBQ==; + context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; k=ed25519; p=mIvJLdOjNKjRin2c6qJUrRl6dDWKW/qSdS4HDMRdBQM=" + context.go:17: Parsed public key: [ed25519:988bc92dd3a334a8] context.go:17: Body hash matches: "2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=" context.go:17: Hashing header: "from:Joe SixPack \r\n" context.go:17: Hashing header: "subject:Is dinner ready?\r\n" context.go:17: Hashing header: "date:Fri, 11 Jul 2003 21:00:37 -0700 (PDT)\r\n" context.go:17: Hashing header: "to:Suzie Q \r\n" context.go:17: Hashing header: "message-id:<20030712040037.46341.5F8J@football.example.com>\r\n" - context.go:17: Hashing header: "dkim-signature:v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1768942910; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "oCf54A7ebD8v7ZT7A+9NtocwWwVSwIlFCKdHJezoudw=" - context.go:17: PK [ed25519:4a3159c75a63fc9c]: Verification succeeded + context.go:17: Hashing header: "dkim-signature:v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1734533054; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "QNu1YVWiO5c/BqoSHbKNEgs77sPgyRli9E3FrACThxA=" + context.go:17: PK [ed25519:988bc92dd3a334a8]: Verification succeeded context.go:17: Found 1 signatures, 1 valid ---- PASS: TestSignEd25519 (0.00s) +--- PASS: TestSignEd25519 (0.02s) === RUN TestSignBadMessage --- PASS: TestSignBadMessage (0.00s) === RUN TestSignBadAlgorithm @@ -1701,25 +1736,25 @@ --- PASS: FuzzParsePublicKey/seed#12 (0.00s) --- PASS: FuzzParsePublicKey/seed#13 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/dkim 0.293s +ok blitiri.com.ar/go/chasquid/internal/dkim 0.719s === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_3763686721" + testlib.go:32: test directory: "/tmp/testlib_1748043922" _ 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.00s) +--- PASS: TestBasic (0.34s) === RUN TestNewDomain - testlib.go:32: test directory: "/tmp/testlib_4182056781" + testlib.go:32: test directory: "/tmp/testlib_1957300360" _ 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.00s) +--- PASS: TestNewDomain (0.06s) === RUN TestProgressions - testlib.go:32: test directory: "/tmp/testlib_1589256867" + testlib.go:32: test directory: "/tmp/testlib_1295008548" _ 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 @@ -1732,29 +1767,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.00s) +--- PASS: TestProgressions (0.20s) === RUN TestErrors - testlib.go:32: test directory: "/tmp/testlib_177753455" + testlib.go:32: test directory: "/tmp/testlib_3447858736" _ 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.00s) +--- PASS: TestErrors (0.16s) === RUN TestDirectoryErrors - testlib.go:32: test directory: "/tmp/testlib_2136533224" -_ domaininfo.go:59 DomainInfo.Reload reload: error: open /tmp/testlib_2136533224/db: no such file or directory -_ domaininfo.go:84 DomainInfo.write d1: error: open /tmp/testlib_2136533224/db/.s:d11163372577: no such file or directory + testlib.go:32: test directory: "/tmp/testlib_3449813514" +_ domaininfo.go:59 DomainInfo.Reload reload: error: open /tmp/testlib_3449813514/db: no such file or directory +_ domaininfo.go:84 DomainInfo.write d1: error: open /tmp/testlib_3449813514/db/.s:d13169416225: no such file or directory --- PASS: TestDirectoryErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/domaininfo 0.015s +ok blitiri.com.ar/go/chasquid/internal/domaininfo 0.840s === RUN TestUsernameNotSafe --- PASS: TestUsernameNotSafe (0.00s) === RUN TestAutodetect - testlib.go:32: test directory: "/tmp/testlib_2997241504" + testlib.go:32: test directory: "/tmp/testlib_4095254872" --- PASS: TestAutodetect (0.00s) === RUN TestReload --- PASS: TestReload (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/dovecot 0.007s +ok blitiri.com.ar/go/chasquid/internal/dovecot 0.044s === RUN TestSplit --- PASS: TestSplit (0.00s) === RUN TestDomainIn @@ -1762,13 +1797,13 @@ === RUN TestAddHeader --- PASS: TestAddHeader (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/envelope 0.003s +ok blitiri.com.ar/go/chasquid/internal/envelope 0.039s === RUN TestHandler ---- PASS: TestHandler (0.00s) +--- PASS: TestHandler (0.01s) === RUN TestMapLabelAccident --- PASS: TestMapLabelAccident (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/expvarom 0.007s +ok blitiri.com.ar/go/chasquid/internal/expvarom 0.052s === RUN TestNoNewline --- PASS: TestNoNewline (0.00s) === RUN TestBasic @@ -1793,21 +1828,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.005s +ok blitiri.com.ar/go/chasquid/internal/haproxy 0.064s === RUN TestBadServer - asm_amd64.s:1700: FakeServer &{{0xc000280080}}: accepted - asm_amd64.s:1700: FakeServer &{{0xc000280080}}: readRequest: "" "" / EOF - asm_amd64.s:1700: FakeServer &{{0xc000280080}}: writeMessage("xxx"): 0 write unix /tmp/rpc-test-1207394878/rpc.sock->@: write: broken pipe - asm_amd64.s:1700: FakeServer &{{0xc000280080}}: closing - asm_amd64.s:1700: FakeServer &{{0xc000280200}}: accepted - asm_amd64.s:1700: FakeServer &{{0xc000280200}}: readRequest: "Echo" "" / - asm_amd64.s:1700: FakeServer &{{0xc000280200}}: writeMessage("xxx"): 3 - asm_amd64.s:1700: FakeServer &{{0xc000280200}}: closing + asm_amd64.s:1700: FakeServer &{{0xc0000b6480}}: accepted + asm_amd64.s:1700: FakeServer &{{0xc0000b6480}}: readRequest: "" "" / EOF + asm_amd64.s:1700: FakeServer &{{0xc0000b6480}}: writeMessage("xxx"): 0 write unix /tmp/rpc-test-1898074590/rpc.sock->@: write: broken pipe + asm_amd64.s:1700: FakeServer &{{0xc0000b6480}}: closing + asm_amd64.s:1700: FakeServer &{{0xc0000b6600}}: accepted + asm_amd64.s:1700: FakeServer &{{0xc0000b6600}}: readRequest: "Echo" "" / + asm_amd64.s:1700: FakeServer &{{0xc0000b6600}}: writeMessage("xxx"): 3 + asm_amd64.s:1700: FakeServer &{{0xc0000b6600}}: closing --- PASS: TestBadServer (0.01s) === RUN TestBadSocket --- PASS: TestBadSocket (0.00s) === RUN TestEndToEnd -_ localrpc.go:63 LocalRPC.Server /tmp/rpc-test-47004148/sock: Listening +_ localrpc.go:63 LocalRPC.Server /tmp/rpc-test-2998578885/sock: Listening === RUN TestEndToEnd/Echo === RUN TestEndToEnd/Echo#01 === RUN TestEndToEnd/Hola @@ -1815,8 +1850,8 @@ _ 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-47004148/sock: error: Accept error: accept unix /tmp/rpc-test-47004148/sock: use of closed network connection ---- PASS: TestEndToEnd (0.01s) +_ localrpc.go:67 LocalRPC.Server /tmp/rpc-test-2998578885/sock: error: Accept error: accept unix /tmp/rpc-test-2998578885/sock: use of closed network connection +--- PASS: TestEndToEnd (0.02s) --- PASS: TestEndToEnd/Echo (0.00s) --- PASS: TestEndToEnd/Echo#01 (0.00s) --- PASS: TestEndToEnd/Hola (0.00s) @@ -1830,7 +1865,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.087s === RUN TestLogger --- PASS: TestLogger (0.00s) === RUN TestDefault @@ -1838,7 +1873,7 @@ === RUN TestFailedLogger --- PASS: TestFailedLogger (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/maillog 0.008s +ok blitiri.com.ar/go/chasquid/internal/maillog 0.041s === RUN TestContext --- PASS: TestContext (0.00s) === RUN TestHistogramBasic @@ -1846,15 +1881,15 @@ === RUN TestHistogramEmpty --- PASS: TestHistogramEmpty (0.00s) === RUN TestHTTP ---- PASS: TestHTTP (0.01s) +--- PASS: TestHTTP (0.03s) === RUN TestHTTPLong ---- PASS: TestHTTPLong (0.00s) +--- PASS: TestHTTPLong (0.01s) === RUN TestHTTPErrors ---- PASS: TestHTTPErrors (0.01s) +--- PASS: TestHTTPErrors (0.03s) === RUN TestHTTPUroboro ---- PASS: TestHTTPUroboro (0.00s) +--- PASS: TestHTTPUroboro (0.07s) === RUN TestHTTPDeep ---- PASS: TestHTTPDeep (0.01s) +--- PASS: TestHTTPDeep (0.02s) === RUN TestStripZeros --- PASS: TestStripZeros (0.00s) === RUN TestRegisterHandler @@ -1874,7 +1909,7 @@ === RUN TestFindParent --- PASS: TestFindParent (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/nettrace 0.038s +ok blitiri.com.ar/go/chasquid/internal/nettrace 0.202s === RUN TestUser --- PASS: TestUser (0.00s) === RUN TestDomain @@ -1891,7 +1926,7 @@ === RUN FuzzUser/6d603c8b9fbe8b9aa021dbde499ec1b3a00922b9338c68b2984cd314c3d5e633 === RUN FuzzUser/ccde73fe7b7352806a87cece8eb81867bdeb177019b69a4bb3c7bb5a277b9c32 === RUN FuzzUser/dc0204d8e2ab058a763873d2a5fede806e95235771ecdd96b56c906886822c19 ---- PASS: FuzzUser (0.00s) +--- PASS: FuzzUser (0.02s) --- PASS: FuzzUser/263da65bb5a59369f294d26a64a36a989a9a36ed5c60950b123e395bedbe881c (0.00s) --- PASS: FuzzUser/31400a53be6363c91bf6585789663189fa30b16181c1d18f19708acccc85f4a1 (0.00s) --- PASS: FuzzUser/6d603c8b9fbe8b9aa021dbde499ec1b3a00922b9338c68b2984cd314c3d5e633 (0.00s) @@ -1927,47 +1962,47 @@ === RUN FuzzDomainToUnicode/ccde73fe7b7352806a87cece8eb81867bdeb177019b69a4bb3c7bb5a277b9c32 === RUN FuzzDomainToUnicode/d8637022b61fb5c4df4e153063564accd6331debaafdd594405c320a5e9f2e70 === RUN FuzzDomainToUnicode/dc0204d8e2ab058a763873d2a5fede806e95235771ecdd96b56c906886822c19 ---- PASS: FuzzDomainToUnicode (0.00s) +--- PASS: FuzzDomainToUnicode (0.01s) --- PASS: FuzzDomainToUnicode/31400a53be6363c91bf6585789663189fa30b16181c1d18f19708acccc85f4a1 (0.00s) --- PASS: FuzzDomainToUnicode/7aba1e0ef80990ccac3731800dbb0267c4c8b7156d4da3b8a5f1b57a570adfb8 (0.00s) --- PASS: FuzzDomainToUnicode/ccde73fe7b7352806a87cece8eb81867bdeb177019b69a4bb3c7bb5a277b9c32 (0.00s) --- PASS: FuzzDomainToUnicode/d8637022b61fb5c4df4e153063564accd6331debaafdd594405c320a5e9f2e70 (0.00s) --- PASS: FuzzDomainToUnicode/dc0204d8e2ab058a763873d2a5fede806e95235771ecdd96b56c906886822c19 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/normalize 0.007s +ok blitiri.com.ar/go/chasquid/internal/normalize 0.052s === RUN TestBin - testlib.go:32: test directory: "/tmp/testlib_3511611136" + testlib.go:32: test directory: "/tmp/testlib_3674035069" --- PASS: TestBin (0.00s) === RUN TestText - testlib.go:32: test directory: "/tmp/testlib_3215016370" + testlib.go:32: test directory: "/tmp/testlib_1448342651" --- PASS: TestText (0.00s) === RUN TestStore - testlib.go:32: test directory: "/tmp/testlib_1695566404" ---- PASS: TestStore (0.00s) + testlib.go:32: test directory: "/tmp/testlib_3399487395" +--- PASS: TestStore (0.01s) === RUN TestFileErrors - testlib.go:32: test directory: "/tmp/testlib_2517931327" + testlib.go:32: test directory: "/tmp/testlib_424028755" --- PASS: TestFileErrors (0.00s) === RUN TestMarshalErrors - testlib.go:32: test directory: "/tmp/testlib_1853375331" + testlib.go:32: test directory: "/tmp/testlib_3075307969" --- PASS: TestMarshalErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/protoio 0.009s +ok blitiri.com.ar/go/chasquid/internal/protoio 0.084s === RUN TestDSN dsn_test.go:49: From: Mail Delivery System To: Subject: Mail delivery failed: returning message to sender - Message-ID: - Date: Tue, 20 Jan 2026 21:01:50 +0000 + Message-ID: + Date: Wed, 18 Dec 2024 14:44:17 +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="sc-oJ4WOhzc" + boundary="Sn19F44Hv60" - --sc-oJ4WOhzc + --Sn19F44Hv60 Content-Type: text/plain; charset="utf-8" Content-Disposition: inline Content-Description: Notification @@ -1992,7 +2027,7 @@ oh! the humanity! - --sc-oJ4WOhzc + --Sn19F44Hv60 Content-Type: message/global-delivery-status Content-Description: Delivery Report Content-Transfer-Encoding: 8bit @@ -2023,7 +2058,7 @@ - --sc-oJ4WOhzc + --Sn19F44Hv60 Content-Type: message/rfc822 Content-Description: Undelivered Message Content-Transfer-Encoding: 8bit @@ -2033,83 +2068,76 @@ Data ñaca. - --sc-oJ4WOhzc-- + --Sn19F44Hv60-- --- PASS: TestDSN (0.00s) === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_1303873233" -_ queue.go:308 Queue.SendLoop yRXGDb3bhD0: from from -_ queue.go:367 Queue.SendLoop yRXGDb3bhD0: nodomain sent -_ queue.go:367 Queue.SendLoop yRXGDb3bhD0: am@loco sent -_ queue.go:367 Queue.SendLoop yRXGDb3bhD0: x@remote sent -_ queue.go:342 Queue.SendLoop yRXGDb3bhD0: all done ---- PASS: TestBasic (0.03s) + testlib.go:32: test directory: "/tmp/testlib_4085872541" +_ queue.go:308 Queue.SendLoop dSCvIGpTZiI: from from +_ queue.go:367 Queue.SendLoop dSCvIGpTZiI: nodomain sent +_ queue.go:367 Queue.SendLoop dSCvIGpTZiI: am@loco sent +_ queue.go:367 Queue.SendLoop dSCvIGpTZiI: x@remote sent +_ queue.go:342 Queue.SendLoop dSCvIGpTZiI: all done +--- PASS: TestBasic (0.09s) === RUN TestDSNOnTimeout - testlib.go:32: test directory: "/tmp/testlib_2034519036" -_ queue.go:308 Queue.SendLoop np2pTdB2OSA: from from@loco -_ queue.go:467 Queue.SendLoop np2pTdB2OSA: queued DSN: _fa6-_YuDAE -_ queue.go:342 Queue.SendLoop np2pTdB2OSA: all done -_ queue.go:308 Queue.SendLoop _fa6-_YuDAE: from <> -_ queue.go:367 Queue.SendLoop _fa6-_YuDAE: from@loco sent -_ queue.go:342 Queue.SendLoop _fa6-_YuDAE: all done -E queue.go:230 failed to remove queue file "/tmp/testlib_2034519036/m:_fa6-_YuDAE": remove /tmp/testlib_2034519036/m:_fa6-_YuDAE: no such file or directory ---- PASS: TestDSNOnTimeout (0.00s) + testlib.go:32: test directory: "/tmp/testlib_591618957" +_ queue.go:308 Queue.SendLoop vbPS1EKfuTc: from from@loco +_ queue.go:467 Queue.SendLoop vbPS1EKfuTc: queued DSN: 7fRFXKvAL_4 +_ queue.go:342 Queue.SendLoop vbPS1EKfuTc: all done +_ queue.go:308 Queue.SendLoop 7fRFXKvAL_4: from <> +_ queue.go:367 Queue.SendLoop 7fRFXKvAL_4: from@loco sent +_ queue.go:342 Queue.SendLoop 7fRFXKvAL_4: all done +--- PASS: TestDSNOnTimeout (0.05s) === RUN TestAliases - testlib.go:32: test directory: "/tmp/testlib_944352581" -_ queue.go:308 Queue.SendLoop wGurNXN8l-A: from from -_ queue.go:367 Queue.SendLoop wGurNXN8l-A: ata@hualpa sent ---- PASS: TestAliases (0.00s) + testlib.go:32: test directory: "/tmp/testlib_4282698690" +_ queue.go:308 Queue.SendLoop ylui2HM97x8: from from +_ queue.go:367 Queue.SendLoop ylui2HM97x8: ata@hualpa sent +_ queue.go:367 Queue.SendLoop ylui2HM97x8: pq@loco sent +_ queue.go:367 Queue.SendLoop ylui2HM97x8: rs@loco sent +_ queue.go:342 Queue.SendLoop ylui2HM97x8: all done +--- PASS: TestAliases (0.19s) === RUN TestFullQueue -_ queue.go:375 Queue.SendLoop wGurNXN8l-A: error: failed to write: rename /tmp/testlib_944352581/.m:wGurNXN8l-A2587490846 /tmp/testlib_944352581/m:wGurNXN8l-A: no such file or directory -_ queue.go:367 Queue.SendLoop wGurNXN8l-A: pq@loco sent -_ queue.go:375 Queue.SendLoop wGurNXN8l-A: error: failed to write: open /tmp/testlib_944352581/.m:wGurNXN8l-A3223349203: no such file or directory -_ queue.go:367 Queue.SendLoop wGurNXN8l-A: rs@loco sent - testlib.go:32: test directory: "/tmp/testlib_1718919078" -_ queue.go:375 Queue.SendLoop wGurNXN8l-A: error: failed to write: open /tmp/testlib_944352581/.m:wGurNXN8l-A19282852: no such file or directory -_ queue.go:342 Queue.SendLoop wGurNXN8l-A: all done -E queue.go:230 failed to remove queue file "/tmp/testlib_944352581/m:wGurNXN8l-A": remove /tmp/testlib_944352581/m:wGurNXN8l-A: no such file or directory + testlib.go:32: test directory: "/tmp/testlib_1779762717" _ queue.go:164 Queue.Put from: error: queue full -_ queue.go:308 Queue.SendLoop DBf0HLjSrLQ: from from --- PASS: TestFullQueue (0.00s) -_ queue.go:367 Queue.SendLoop DBf0HLjSrLQ: to sent === RUN TestPipes -_ queue.go:375 Queue.SendLoop DBf0HLjSrLQ: error: failed to write: open /tmp/testlib_1718919078/.m:DBf0HLjSrLQ2317409558: no such file or directory -_ queue.go:342 Queue.SendLoop DBf0HLjSrLQ: all done -E queue.go:230 failed to remove queue file "/tmp/testlib_1718919078/m:DBf0HLjSrLQ": remove /tmp/testlib_1718919078/m:DBf0HLjSrLQ: no such file or directory - testlib.go:32: test directory: "/tmp/testlib_258865018" ---- PASS: TestPipes (0.00s) + testlib.go:32: test directory: "/tmp/testlib_3319653420" +_ queue.go:308 Queue.SendLoop tPiE_qlqtW0: from from +_ queue.go:367 Queue.SendLoop tPiE_qlqtW0: to sent +_ queue.go:375 Queue.SendLoop tPiE_qlqtW0: error: failed to write: open /tmp/testlib_1779762717/.m:tPiE_qlqtW02739074764: no such file or directory +_ queue.go:342 Queue.SendLoop tPiE_qlqtW0: all done +E queue.go:230 failed to remove queue file "/tmp/testlib_1779762717/m:tPiE_qlqtW0": remove /tmp/testlib_1779762717/m:tPiE_qlqtW0: no such file or directory +--- PASS: TestPipes (0.17s) === RUN TestBadPath --- PASS: TestBadPath (0.00s) === RUN TestNextDelay --- PASS: TestNextDelay (0.00s) === RUN TestSerialization - testlib.go:32: test directory: "/tmp/testlib_2078684676" -_ queue.go:308 Queue.SendLoop zWDEJDjWmtU: from from@loco -_ queue.go:367 Queue.SendLoop zWDEJDjWmtU: to@to sent -_ queue.go:375 Queue.SendLoop zWDEJDjWmtU: error: failed to write: rename /tmp/testlib_2078684676/.m:zWDEJDjWmtU1398522208 /tmp/testlib_2078684676/m:zWDEJDjWmtU: no such file or directory -_ queue.go:342 Queue.SendLoop zWDEJDjWmtU: all done + testlib.go:32: test directory: "/tmp/testlib_3137011755" +_ queue.go:308 Queue.SendLoop -xUNICoh978: from from@loco +_ queue.go:367 Queue.SendLoop -xUNICoh978: to@to sent +_ queue.go:342 Queue.SendLoop -xUNICoh978: all done --- PASS: TestSerialization (0.00s) -E queue.go:230 failed to remove queue file "/tmp/testlib_2078684676/m:zWDEJDjWmtU": remove /tmp/testlib_2078684676/m:zWDEJDjWmtU: no such file or directory PASS -ok blitiri.com.ar/go/chasquid/internal/queue 0.039s +ok blitiri.com.ar/go/chasquid/internal/queue 0.682s === RUN TestWriteFile - testlib.go:32: test directory: "/tmp/testlib_2368138604" ---- PASS: TestWriteFile (0.00s) + testlib.go:32: test directory: "/tmp/testlib_4245054716" +--- PASS: TestWriteFile (0.03s) === RUN TestWriteFileWithOp - testlib.go:32: test directory: "/tmp/testlib_1606808605" + testlib.go:32: test directory: "/tmp/testlib_2836698039" --- PASS: TestWriteFileWithOp (0.00s) === RUN TestWriteFileWithFailingOp - testlib.go:32: test directory: "/tmp/testlib_2919246873" + testlib.go:32: test directory: "/tmp/testlib_1344045781" --- PASS: TestWriteFileWithFailingOp (0.00s) === RUN TestErrors - testlib.go:32: test directory: "/tmp/testlib_492213751" + testlib.go:32: test directory: "/tmp/testlib_3393185419" --- PASS: TestErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/safeio 0.006s +ok blitiri.com.ar/go/chasquid/internal/safeio 0.146s === RUN TestString --- PASS: TestString (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/set 0.003s +ok blitiri.com.ar/go/chasquid/internal/set 0.097s === RUN TestIsPermanent --- PASS: TestIsPermanent (0.00s) === RUN TestIsASCII @@ -2123,21 +2151,22 @@ === RUN TestFallbackToIDNA --- PASS: TestFallbackToIDNA (0.00s) === RUN TestLineTooLong ---- PASS: TestLineTooLong (0.03s) +--- PASS: TestLineTooLong (0.14s) PASS -ok blitiri.com.ar/go/chasquid/internal/smtp 0.036s -_ server.go:296 Server listening on 127.0.0.1:44163 (SMTP) -2026-01-20 21:01:50.968887 daemon listening on 127.0.0.1:44163 -_ server.go:296 Server listening on 127.0.0.1:43527 (submission) -2026-01-20 21:01:50.969046 daemon listening on 127.0.0.1:43527 -_ server.go:296 Server listening on 127.0.0.1:45197 (submission+TLS) -2026-01-20 21:01:50.969085 daemon listening on 127.0.0.1:45197 +ok blitiri.com.ar/go/chasquid/internal/smtp 0.248s +? blitiri.com.ar/go/chasquid/internal/trace [no test files] +_ server.go:296 Server listening on 127.0.0.1:36549 (SMTP) +2024-12-18 14:44:20.054077 daemon listening on 127.0.0.1:36549 +_ server.go:296 Server listening on 127.0.0.1:45885 (submission) +2024-12-18 14:44:20.054225 daemon listening on 127.0.0.1:45885 +_ server.go:296 Server listening on 127.0.0.1:35227 (submission+TLS) +2024-12-18 14:44:20.054273 daemon listening on 127.0.0.1:35227 === RUN TestSecLevel -_ conn.go:209 SMTP.Conn 127.0.0.1:53300: error: error completing TLS handshake: EOF +_ conn.go:209 SMTP.Conn 127.0.0.1:60898: 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:559 testconn testconn: error: security level check for slc failed (PLAIN) ---- PASS: TestSecLevel (0.00s) +--- PASS: TestSecLevel (0.17s) === RUN TestIsHeader --- PASS: TestIsHeader (0.00s) === RUN TestAddrLiteral @@ -2149,184 +2178,184 @@ === RUN TestReadUntilDotReadError --- PASS: TestReadUntilDotReadError (0.00s) === RUN TestSimple -_ conn.go:722 SMTP.Conn 127.0.0.1:41372: Queued from from@from to [to@localhost] - WC3JsQM3fsQ -2026-01-20 21:01:51.072761 WC3JsQM3fsQ from=from@from queued ip=127.0.0.1:41372 to=[to@localhost] -_ queue.go:308 Queue.SendLoop WC3JsQM3fsQ: from from@from -_ queue.go:367 Queue.SendLoop WC3JsQM3fsQ: testuser@localhost sent -2026-01-20 21:01:51.072876 WC3JsQM3fsQ from=from@from to=testuser@localhost sent ---- PASS: TestSimple (0.00s) +_ conn.go:722 SMTP.Conn 127.0.0.1:43782: Queued from from@from to [to@localhost] - HeMFhase7fw +2024-12-18 14:44:20.332009 HeMFhase7fw from=from@from queued ip=127.0.0.1:43782 to=[to@localhost] +_ queue.go:308 Queue.SendLoop HeMFhase7fw: from from@from +_ queue.go:367 Queue.SendLoop HeMFhase7fw: testuser@localhost sent +2024-12-18 14:44:20.332188 HeMFhase7fw from=from@from to=testuser@localhost sent +--- PASS: TestSimple (0.01s) === RUN TestSimpleTLS -_ queue.go:342 Queue.SendLoop WC3JsQM3fsQ: all done -2026-01-20 21:01:51.073085 WC3JsQM3fsQ from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:41384: Queued from from@from to [to@localhost] - 2LCprhL-DAQ -2026-01-20 21:01:51.075335 2LCprhL-DAQ from=from@from queued ip=127.0.0.1:41384 to=[to@localhost] -_ queue.go:308 Queue.SendLoop 2LCprhL-DAQ: from from@from -_ queue.go:367 Queue.SendLoop 2LCprhL-DAQ: testuser@localhost sent -2026-01-20 21:01:51.075423 2LCprhL-DAQ from=from@from to=testuser@localhost sent ---- PASS: TestSimpleTLS (0.00s) +_ queue.go:342 Queue.SendLoop HeMFhase7fw: all done +2024-12-18 14:44:20.414055 HeMFhase7fw from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:43796: Queued from from@from to [to@localhost] - tcZ6rmCedS4 +2024-12-18 14:44:20.419100 tcZ6rmCedS4 from=from@from queued ip=127.0.0.1:43796 to=[to@localhost] +_ queue.go:308 Queue.SendLoop tcZ6rmCedS4: from from@from +_ queue.go:367 Queue.SendLoop tcZ6rmCedS4: testuser@localhost sent +2024-12-18 14:44:20.419835 tcZ6rmCedS4 from=from@from to=testuser@localhost sent +--- PASS: TestSimpleTLS (0.09s) === RUN TestManyEmails -_ queue.go:342 Queue.SendLoop 2LCprhL-DAQ: all done -2026-01-20 21:01:51.075644 2LCprhL-DAQ from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:41398: Queued from from@from to [to@localhost] - jv33p9JYBQw -2026-01-20 21:01:51.077673 jv33p9JYBQw from=from@from queued ip=127.0.0.1:41398 to=[to@localhost] -_ queue.go:308 Queue.SendLoop jv33p9JYBQw: from from@from -_ queue.go:367 Queue.SendLoop jv33p9JYBQw: testuser@localhost sent -2026-01-20 21:01:51.077789 jv33p9JYBQw from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop jv33p9JYBQw: all done -2026-01-20 21:01:51.078019 jv33p9JYBQw from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:41398: Queued from from@from to [to@localhost] - 3H_lzwfmAXk -2026-01-20 21:01:51.078395 3H_lzwfmAXk from=from@from queued ip=127.0.0.1:41398 to=[to@localhost] -_ queue.go:308 Queue.SendLoop 3H_lzwfmAXk: from from@from -_ queue.go:367 Queue.SendLoop 3H_lzwfmAXk: testuser@localhost sent -2026-01-20 21:01:51.078500 3H_lzwfmAXk from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop 3H_lzwfmAXk: all done -2026-01-20 21:01:51.078684 3H_lzwfmAXk from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:41398: Queued from from@from to [to@localhost] - P-AiYVgTLl0 -2026-01-20 21:01:51.079146 P-AiYVgTLl0 from=from@from queued ip=127.0.0.1:41398 to=[to@localhost] -_ queue.go:308 Queue.SendLoop P-AiYVgTLl0: from from@from -_ queue.go:367 Queue.SendLoop P-AiYVgTLl0: testuser@localhost sent -2026-01-20 21:01:51.079240 P-AiYVgTLl0 from=from@from to=testuser@localhost sent ---- PASS: TestManyEmails (0.00s) +_ queue.go:342 Queue.SendLoop tcZ6rmCedS4: all done +2024-12-18 14:44:20.420793 tcZ6rmCedS4 from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:43812: Queued from from@from to [to@localhost] - hsaSI7W_1BA +2024-12-18 14:44:20.434770 hsaSI7W_1BA from=from@from queued ip=127.0.0.1:43812 to=[to@localhost] +_ queue.go:308 Queue.SendLoop hsaSI7W_1BA: from from@from +_ queue.go:367 Queue.SendLoop hsaSI7W_1BA: testuser@localhost sent +2024-12-18 14:44:20.435219 hsaSI7W_1BA from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop hsaSI7W_1BA: all done +2024-12-18 14:44:20.494135 hsaSI7W_1BA from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:43812: Queued from from@from to [to@localhost] - uArIgHXimd8 +2024-12-18 14:44:20.495516 uArIgHXimd8 from=from@from queued ip=127.0.0.1:43812 to=[to@localhost] +_ queue.go:308 Queue.SendLoop uArIgHXimd8: from from@from +_ queue.go:367 Queue.SendLoop uArIgHXimd8: testuser@localhost sent +2024-12-18 14:44:20.496025 uArIgHXimd8 from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop uArIgHXimd8: all done +2024-12-18 14:44:20.496489 uArIgHXimd8 from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:43812: Queued from from@from to [to@localhost] - 3Q_GTGNvr1Y +2024-12-18 14:44:20.499333 3Q_GTGNvr1Y from=from@from queued ip=127.0.0.1:43812 to=[to@localhost] +_ queue.go:308 Queue.SendLoop 3Q_GTGNvr1Y: from from@from +_ queue.go:367 Queue.SendLoop 3Q_GTGNvr1Y: testuser@localhost sent +2024-12-18 14:44:20.499474 3Q_GTGNvr1Y from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop 3Q_GTGNvr1Y: all done +2024-12-18 14:44:20.499905 3Q_GTGNvr1Y from=from@from all done +--- PASS: TestManyEmails (0.08s) === RUN TestAuth -_ queue.go:342 Queue.SendLoop P-AiYVgTLl0: all done -2026-01-20 21:01:51.079405 P-AiYVgTLl0 from=from@from all done -2026-01-20 21:01:51.183300 127.0.0.1:56730 auth succeeded for testuser@localhost -_ conn.go:722 SMTP.Conn 127.0.0.1:56730: Queued from testuser@localhost to [to@localhost] - vHcqSXcJxmQ -2026-01-20 21:01:51.184060 vHcqSXcJxmQ from=testuser@localhost queued ip=127.0.0.1:56730 to=[to@localhost] -_ queue.go:308 Queue.SendLoop vHcqSXcJxmQ: from testuser@localhost -_ queue.go:367 Queue.SendLoop vHcqSXcJxmQ: testuser@localhost sent -2026-01-20 21:01:51.184153 vHcqSXcJxmQ from=testuser@localhost to=testuser@localhost sent ---- PASS: TestAuth (0.10s) -_ queue.go:342 Queue.SendLoop vHcqSXcJxmQ: all done +2024-12-18 14:44:20.683766 127.0.0.1:35496 auth succeeded for testuser@localhost +_ conn.go:722 SMTP.Conn 127.0.0.1:35496: Queued from testuser@localhost to [to@localhost] - rEpdvAJ0bcM +2024-12-18 14:44:20.686979 rEpdvAJ0bcM from=testuser@localhost queued ip=127.0.0.1:35496 to=[to@localhost] +_ queue.go:308 Queue.SendLoop rEpdvAJ0bcM: from testuser@localhost +_ queue.go:367 Queue.SendLoop rEpdvAJ0bcM: testuser@localhost sent +2024-12-18 14:44:20.687147 rEpdvAJ0bcM from=testuser@localhost to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop rEpdvAJ0bcM: all done +2024-12-18 14:44:20.687535 rEpdvAJ0bcM from=testuser@localhost all done +--- PASS: TestAuth (0.19s) === RUN TestSubmissionWithoutAuth -2026-01-20 21:01:51.184388 vHcqSXcJxmQ from=testuser@localhost all done -_ conn.go:318 SMTP.Conn 127.0.0.1:56734: error: MAIL failed: 550 5.7.9 Mail to submission port must be authenticated ---- PASS: TestSubmissionWithoutAuth (0.00s) +_ conn.go:318 SMTP.Conn 127.0.0.1:35510: error: MAIL failed: 550 5.7.9 Mail to submission port must be authenticated +--- PASS: TestSubmissionWithoutAuth (0.01s) === RUN TestAuthOnTLS -2026-01-20 21:01:51.294471 127.0.0.1:53314 auth succeeded for testuser@localhost -_ conn.go:722 SMTP.Conn 127.0.0.1:53314: Queued from testuser@localhost to [to@localhost] - r5CqwYSoLYU -2026-01-20 21:01:51.295451 r5CqwYSoLYU from=testuser@localhost queued ip=127.0.0.1:53314 to=[to@localhost] -_ queue.go:308 Queue.SendLoop r5CqwYSoLYU: from testuser@localhost -_ queue.go:367 Queue.SendLoop r5CqwYSoLYU: testuser@localhost sent -2026-01-20 21:01:51.295619 r5CqwYSoLYU from=testuser@localhost to=testuser@localhost sent ---- PASS: TestAuthOnTLS (0.11s) +2024-12-18 14:44:20.957591 127.0.0.1:32928 auth succeeded for testuser@localhost +_ conn.go:722 SMTP.Conn 127.0.0.1:32928: Queued from testuser@localhost to [to@localhost] - mrR2QJHECIE +2024-12-18 14:44:20.970200 mrR2QJHECIE from=testuser@localhost queued ip=127.0.0.1:32928 to=[to@localhost] +_ queue.go:308 Queue.SendLoop mrR2QJHECIE: from testuser@localhost +_ queue.go:367 Queue.SendLoop mrR2QJHECIE: testuser@localhost sent +2024-12-18 14:44:20.970700 mrR2QJHECIE from=testuser@localhost to=testuser@localhost sent +--- PASS: TestAuthOnTLS (0.28s) === RUN TestAuthOnSMTP -_ queue.go:342 Queue.SendLoop r5CqwYSoLYU: all done -2026-01-20 21:01:51.296025 r5CqwYSoLYU from=testuser@localhost all done -2026-01-20 21:01:51.402472 127.0.0.1:41408 auth succeeded for testuser@localhost -_ conn.go:722 SMTP.Conn 127.0.0.1:41408: Queued from testuser@localhost to [to@localhost] - VPaNR7O4C4Y -2026-01-20 21:01:51.403213 VPaNR7O4C4Y from=testuser@localhost queued ip=127.0.0.1:41408 to=[to@localhost] -_ queue.go:308 Queue.SendLoop VPaNR7O4C4Y: from testuser@localhost -_ queue.go:367 Queue.SendLoop VPaNR7O4C4Y: testuser@localhost sent -2026-01-20 21:01:51.403305 VPaNR7O4C4Y from=testuser@localhost to=testuser@localhost sent ---- PASS: TestAuthOnSMTP (0.11s) +_ queue.go:342 Queue.SendLoop mrR2QJHECIE: all done +2024-12-18 14:44:21.193878 mrR2QJHECIE from=testuser@localhost all done +2024-12-18 14:44:21.302684 127.0.0.1:43822 auth succeeded for testuser@localhost +_ conn.go:722 SMTP.Conn 127.0.0.1:43822: Queued from testuser@localhost to [to@localhost] - stXJZv6sfwM +2024-12-18 14:44:21.308536 stXJZv6sfwM from=testuser@localhost queued ip=127.0.0.1:43822 to=[to@localhost] +_ queue.go:308 Queue.SendLoop stXJZv6sfwM: from testuser@localhost +_ queue.go:367 Queue.SendLoop stXJZv6sfwM: testuser@localhost sent +2024-12-18 14:44:21.308791 stXJZv6sfwM from=testuser@localhost to=testuser@localhost sent +--- PASS: TestAuthOnSMTP (0.32s) === RUN TestBrokenAuth -_ queue.go:342 Queue.SendLoop VPaNR7O4C4Y: all done -2026-01-20 21:01:51.403514 VPaNR7O4C4Y from=testuser@localhost all done -_ conn.go:1193 SMTP.Conn 127.0.0.1:56738: error: error authenticating \"user\"@\"broken\": failed to auth -2026-01-20 21:01:51.525490 127.0.0.1:56738 auth failed for user@broken -_ conn.go:318 SMTP.Conn 127.0.0.1:56738: error: AUTH failed: 454 4.7.0 Temporary authentication failure -_ conn.go:318 SMTP.Conn 127.0.0.1:56738: error: unknown<\"*\"> failed: 500 5.5.1 Unknown command ---- PASS: TestBrokenAuth (0.12s) +_ queue.go:342 Queue.SendLoop stXJZv6sfwM: all done +2024-12-18 14:44:21.362927 stXJZv6sfwM from=testuser@localhost all done +_ conn.go:1193 SMTP.Conn 127.0.0.1:35526: error: error authenticating \"user\"@\"broken\": failed to auth +2024-12-18 14:44:21.433931 127.0.0.1:35526 auth failed for user@broken +_ conn.go:318 SMTP.Conn 127.0.0.1:35526: error: AUTH failed: 454 4.7.0 Temporary authentication failure +_ conn.go:318 SMTP.Conn 127.0.0.1:35526: error: unknown<\"*\"> failed: 500 5.5.1 Unknown command +--- PASS: TestBrokenAuth (0.13s) === RUN TestWrongMailParsing -_ conn.go:318 SMTP.Conn 127.0.0.1:41418: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:41418: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:41418: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:41418: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:41422: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:41422: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:41422: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:41422: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:41432: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:41432: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:41432: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:41432: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:41438: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:41438: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:41438: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:41438: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:41442: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:41442: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:41442: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:41442: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:41444: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:41444: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:41444: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:41444: error: too many errors, breaking connection ---- PASS: TestWrongMailParsing (0.00s) +_ conn.go:318 SMTP.Conn 127.0.0.1:43828: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43828: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43828: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43828: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43844: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43844: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43844: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43844: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43858: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43858: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43858: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43858: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43860: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43860: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43860: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43860: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43876: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43876: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43876: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43876: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43882: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43882: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43882: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43882: error: too many errors, breaking connection +--- PASS: TestWrongMailParsing (0.01s) === RUN TestNullMailFrom ---- PASS: TestNullMailFrom (0.00s) +--- PASS: TestNullMailFrom (0.01s) === RUN TestRcptBeforeMail -_ conn.go:318 SMTP.Conn 127.0.0.1:41460: error: RCPT failed: 503 5.5.1 Sender not yet given +_ conn.go:318 SMTP.Conn 127.0.0.1:43910: error: RCPT failed: 503 5.5.1 Sender not yet given --- PASS: TestRcptBeforeMail (0.00s) === RUN TestRcptOption ---- PASS: TestRcptOption (0.00s) +--- PASS: TestRcptOption (0.01s) === RUN TestRelayForbidden -2026-01-20 21:01:51.534127 127.0.0.1:41478 rejected from=from@somewhere to=[to@somewhere] - relay not allowed -_ conn.go:318 SMTP.Conn 127.0.0.1:41478: error: RCPT failed: 503 5.7.1 Relay not allowed +2024-12-18 14:44:21.468170 127.0.0.1:43920 rejected from=from@somewhere to=[to@somewhere] - relay not allowed +_ conn.go:318 SMTP.Conn 127.0.0.1:43920: error: RCPT failed: 503 5.7.1 Relay not allowed --- PASS: TestRelayForbidden (0.00s) === RUN TestTooManyRecipients -2026-01-20 21:01:51.639228 127.0.0.1:56744 auth succeeded for testuser@localhost -_ conn.go:318 SMTP.Conn 127.0.0.1:56744: error: RCPT failed: 452 4.5.3 Too many recipients ---- PASS: TestTooManyRecipients (0.11s) +2024-12-18 14:44:21.769649 127.0.0.1:35530 auth succeeded for testuser@localhost +_ conn.go:318 SMTP.Conn 127.0.0.1:35530: error: RCPT failed: 452 4.5.3 Too many recipients +--- PASS: TestTooManyRecipients (0.32s) === RUN TestRcptBrokenExists -_ conn.go:622 SMTP.Conn 127.0.0.1:41484: error: error checking if user \"to@broken\" exists: failed to check if user exists -2026-01-20 21:01:51.649371 127.0.0.1:41484 rejected from=from@localhost to=[to@broken] - error checking if user exists: failed to check if user exists -_ conn.go:318 SMTP.Conn 127.0.0.1:41484: error: RCPT failed: 451 4.4.3 Temporary error checking address ---- PASS: TestRcptBrokenExists (0.00s) +_ conn.go:622 SMTP.Conn 127.0.0.1:43922: error: error checking if user \"to@broken\" exists: failed to check if user exists +2024-12-18 14:44:21.801204 127.0.0.1:43922 rejected from=from@localhost to=[to@broken] - error checking if user exists: failed to check if user exists +_ conn.go:318 SMTP.Conn 127.0.0.1:43922: error: RCPT failed: 451 4.4.3 Temporary error checking address +--- PASS: TestRcptBrokenExists (0.01s) === RUN TestRcptUserDoesNotExist -2026-01-20 21:01:51.652440 127.0.0.1:41492 rejected from=from@localhost to=[doesnotexist@localhost] - local user does not exist -_ conn.go:318 SMTP.Conn 127.0.0.1:41492: error: RCPT failed: 550 5.1.1 Destination address is unknown (user does not exist) ---- PASS: TestRcptUserDoesNotExist (0.00s) +2024-12-18 14:44:21.809054 127.0.0.1:43924 rejected from=from@localhost to=[doesnotexist@localhost] - local user does not exist +_ conn.go:318 SMTP.Conn 127.0.0.1:43924: error: RCPT failed: 550 5.1.1 Destination address is unknown (user does not exist) +--- PASS: TestRcptUserDoesNotExist (0.01s) === RUN TestTooMuchData -_ conn.go:722 SMTP.Conn 127.0.0.1:41496: Queued from from@from to [to@localhost] - 7es2-c5ECyo -2026-01-20 21:01:51.752252 7es2-c5ECyo from=from@from queued ip=127.0.0.1:41496 to=[to@localhost] -_ queue.go:308 Queue.SendLoop 7es2-c5ECyo: from from@from -_ queue.go:367 Queue.SendLoop 7es2-c5ECyo: testuser@localhost sent -2026-01-20 21:01:51.752360 7es2-c5ECyo from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop 7es2-c5ECyo: all done -2026-01-20 21:01:51.768809 7es2-c5ECyo from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:41496: Queued from from@from to [to@localhost] - TLqsckGIvEg -2026-01-20 21:01:51.850520 TLqsckGIvEg from=from@from queued ip=127.0.0.1:41496 to=[to@localhost] -_ queue.go:308 Queue.SendLoop TLqsckGIvEg: from from@from -_ queue.go:367 Queue.SendLoop TLqsckGIvEg: testuser@localhost sent -2026-01-20 21:01:51.850623 TLqsckGIvEg from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop TLqsckGIvEg: all done -2026-01-20 21:01:51.864205 TLqsckGIvEg from=from@from all done -_ conn.go:318 SMTP.Conn 127.0.0.1:41496: error: DATA failed: 552 5.3.4 Message too big -_ conn.go:722 SMTP.Conn 127.0.0.1:41496: Queued from from@from to [to@localhost] - 2HOg9qTuvTE -2026-01-20 21:01:52.050306 2HOg9qTuvTE from=from@from queued ip=127.0.0.1:41496 to=[to@localhost] -_ queue.go:308 Queue.SendLoop 2HOg9qTuvTE: from from@from -_ queue.go:367 Queue.SendLoop 2HOg9qTuvTE: testuser@localhost sent -2026-01-20 21:01:52.050414 2HOg9qTuvTE from=from@from to=testuser@localhost sent ---- PASS: TestTooMuchData (0.40s) +_ conn.go:722 SMTP.Conn 127.0.0.1:43934: Queued from from@from to [to@localhost] - rg-2R1CVOdM +2024-12-18 14:44:22.769440 rg-2R1CVOdM from=from@from queued ip=127.0.0.1:43934 to=[to@localhost] +_ queue.go:308 Queue.SendLoop rg-2R1CVOdM: from from@from +_ queue.go:367 Queue.SendLoop rg-2R1CVOdM: testuser@localhost sent +2024-12-18 14:44:22.770024 rg-2R1CVOdM from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop rg-2R1CVOdM: all done +2024-12-18 14:44:23.301247 rg-2R1CVOdM from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:43934: Queued from from@from to [to@localhost] - b9WU7zO9aeg +2024-12-18 14:44:23.554587 b9WU7zO9aeg from=from@from queued ip=127.0.0.1:43934 to=[to@localhost] +_ queue.go:308 Queue.SendLoop b9WU7zO9aeg: from from@from +_ queue.go:367 Queue.SendLoop b9WU7zO9aeg: testuser@localhost sent +2024-12-18 14:44:23.555153 b9WU7zO9aeg from=from@from to=testuser@localhost sent +_ conn.go:318 SMTP.Conn 127.0.0.1:43934: error: DATA failed: 552 5.3.4 Message too big +_ queue.go:342 Queue.SendLoop b9WU7zO9aeg: all done +2024-12-18 14:44:24.028868 b9WU7zO9aeg from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:43934: Queued from from@from to [to@localhost] - _Jrx5s2GfW4 +2024-12-18 14:44:24.295151 _Jrx5s2GfW4 from=from@from queued ip=127.0.0.1:43934 to=[to@localhost] +_ queue.go:308 Queue.SendLoop _Jrx5s2GfW4: from from@from +_ queue.go:367 Queue.SendLoop _Jrx5s2GfW4: testuser@localhost sent +2024-12-18 14:44:24.295684 _Jrx5s2GfW4 from=from@from to=testuser@localhost sent +--- PASS: TestTooMuchData (2.49s) === RUN TestSimpleCommands -_ conn.go:318 SMTP.Conn 127.0.0.1:52406: error: VRFY failed: 502 5.5.1 You have a strange feeling for a moment, then it passes. -_ conn.go:318 SMTP.Conn 127.0.0.1:52406: error: EXPN failed: 502 5.5.1 You feel disoriented for a moment. ---- PASS: TestSimpleCommands (0.00s) +_ conn.go:318 SMTP.Conn 127.0.0.1:43948: error: VRFY failed: 502 5.5.1 You have a strange feeling for a moment, then it passes. +_ conn.go:318 SMTP.Conn 127.0.0.1:43948: error: EXPN failed: 502 5.5.1 You feel disoriented for a moment. +--- PASS: TestSimpleCommands (0.01s) === RUN TestLongLines -_ conn.go:318 SMTP.Conn 127.0.0.1:52414: error: unknown<\"\"> failed: 500 5.5.1 Unknown command -_ conn.go:348 SMTP.Conn 127.0.0.1:52414: error: exiting with error: line too long +_ conn.go:318 SMTP.Conn 127.0.0.1:43958: error: unknown<\"\"> failed: 500 5.5.1 Unknown command +_ conn.go:348 SMTP.Conn 127.0.0.1:43958: error: exiting with error: line too long --- PASS: TestLongLines (0.00s) === RUN TestReset ---- PASS: TestReset (0.00s) +--- PASS: TestReset (0.01s) === RUN TestRepeatedStartTLS -_ conn.go:318 SMTP.Conn 127.0.0.1:52422: error: STARTTLS failed: 503 5.5.1 You are already wearing that! ---- PASS: TestRepeatedStartTLS (0.00s) +_ conn.go:318 SMTP.Conn 127.0.0.1:43964: error: STARTTLS failed: 503 5.5.1 You are already wearing that! +--- PASS: TestRepeatedStartTLS (0.02s) === RUN TestStartTLSOnTLS -_ conn.go:318 SMTP.Conn 127.0.0.1:37898: error: STARTTLS failed: 503 5.5.1 You are already wearing that! ---- PASS: TestStartTLSOnTLS (0.00s) +_ conn.go:318 SMTP.Conn 127.0.0.1:32940: error: STARTTLS failed: 503 5.5.1 You are already wearing that! +--- PASS: TestStartTLSOnTLS (0.01s) === RUN TestAddDKIMSigner - testlib.go:32: test directory: "/tmp/testlib_2110523349" ---- PASS: TestAddDKIMSigner (0.00s) + testlib.go:32: test directory: "/tmp/testlib_2740385366" +--- PASS: TestAddDKIMSigner (0.01s) === RUN FuzzConnection --- PASS: FuzzConnection (0.00s) PASS -_ queue.go:375 Queue.SendLoop 2HOg9qTuvTE: error: failed to write: rename /tmp/chasquid_test:225253477/queue/.m:2HOg9qTuvTE2943516058 /tmp/chasquid_test:225253477/queue/m:2HOg9qTuvTE: no such file or directory -_ queue.go:342 Queue.SendLoop 2HOg9qTuvTE: all done -2026-01-20 21:01:52.061435 2HOg9qTuvTE from=from@from all done -E queue.go:230 failed to remove queue file "/tmp/chasquid_test:225253477/queue/m:2HOg9qTuvTE": remove /tmp/chasquid_test:225253477/queue/m:2HOg9qTuvTE: no such file or directory -ok blitiri.com.ar/go/chasquid/internal/smtpsrv 1.203s +_ queue.go:375 Queue.SendLoop _Jrx5s2GfW4: error: failed to write: rename /tmp/chasquid_test:3116656970/queue/.m:_Jrx5s2GfW44163445295 /tmp/chasquid_test:3116656970/queue/m:_Jrx5s2GfW4: no such file or directory +_ queue.go:342 Queue.SendLoop _Jrx5s2GfW4: all done +2024-12-18 14:44:24.386139 _Jrx5s2GfW4 from=from@from all done +E queue.go:230 failed to remove queue file "/tmp/chasquid_test:3116656970/queue/m:_Jrx5s2GfW4": remove /tmp/chasquid_test:3116656970/queue/m:_Jrx5s2GfW4: no such file or directory +ok blitiri.com.ar/go/chasquid/internal/smtpsrv 4.777s === RUN TestParsePolicy sts_test.go:90: pol1: &{Version:STSv1 Mode:enforce MXs:[*.mail.example.com] MaxAge:34h17m36s} --- PASS: TestParsePolicy (0.00s) @@ -2341,34 +2370,34 @@ sts_test.go:210: policy404: got error as expected: HTTP response status code: 404 sts_test.go:218: version99: got expected error: unknown policy version sts_test.go:226: domErr: got expected error: error for testing purposes ---- PASS: TestFetch (0.00s) +--- PASS: TestFetch (0.01s) === RUN TestPolicyTooBig sts_test.go:242: got error as expected: MTA-STS TXT record missing ---- PASS: TestPolicyTooBig (0.01s) +--- PASS: TestPolicyTooBig (0.13s) === RUN TestCacheBasics - testlib.go:32: test directory: "/tmp/testlib_2033579969" + testlib.go:32: test directory: "/tmp/testlib_3991170182" 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.00s) +--- PASS: TestCacheBasics (0.34s) === RUN TestCacheBadData - testlib.go:32: test directory: "/tmp/testlib_157753036" + testlib.go:32: test directory: "/tmp/testlib_2009943861" 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.00s) +--- PASS: TestCacheBadData (0.26s) === RUN TestCacheRefresh - testlib.go:32: test directory: "/tmp/testlib_4169150165" + testlib.go:32: test directory: "/tmp/testlib_53565697" 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.04s) === RUN TestCacheSlashSafe - testlib.go:32: test directory: "/tmp/testlib_4252743836" + testlib.go:32: test directory: "/tmp/testlib_3857421657" sts_test.go:464: recovered: domain contains slash --- PASS: TestCacheSlashSafe (0.00s) === RUN TestURLForDomain @@ -2376,11 +2405,11 @@ === RUN TestHasSTSRecord --- PASS: TestHasSTSRecord (0.00s) === RUN TestHTTPGet ---- PASS: TestHTTPGet (0.00s) +--- PASS: TestHTTPGet (0.02s) PASS -ok blitiri.com.ar/go/chasquid/internal/sts 0.032s +ok blitiri.com.ar/go/chasquid/internal/sts 0.888s === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_1064219165" + testlib.go:32: test directory: "/tmp/testlib_890637651" --- PASS: TestBasic (0.00s) === RUN TestRemoveCheck testlib_test.go:33: recovered: invalid/dangerous directory @@ -2391,54 +2420,54 @@ testlib_test.go:60: recovered: invalid/dangerous path --- PASS: TestRewriteSafeguard (0.00s) === RUN TestRewrite - testlib.go:32: test directory: "/tmp/testlib_1348980721" + testlib.go:32: test directory: "/tmp/testlib_2706517481" --- 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_2047732667" ---- PASS: TestGenerateCert (0.02s) + testlib.go:32: test directory: "/tmp/testlib_382791919" +--- PASS: TestGenerateCert (0.09s) === RUN TestGenerateCertBadDir ---- PASS: TestGenerateCertBadDir (0.05s) +--- PASS: TestGenerateCertBadDir (0.09s) PASS -ok blitiri.com.ar/go/chasquid/internal/testlib 0.092s +ok blitiri.com.ar/go/chasquid/internal/testlib 0.364s === RUN TestVersionName --- PASS: TestVersionName (0.00s) === RUN TestCipherSuiteName --- PASS: TestCipherSuiteName (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/tlsconst 0.003s +ok blitiri.com.ar/go/chasquid/internal/tlsconst 0.040s === RUN TestEmptyLoad - userdb_test.go:37: file: "/tmp/userdb_test1051756819" - userdb_test.go:37: file: "/tmp/userdb_test3796528923" + userdb_test.go:37: file: "/tmp/userdb_test1518421691" + userdb_test.go:37: file: "/tmp/userdb_test2983069608" --- PASS: TestEmptyLoad (0.00s) === RUN TestWrite - userdb_test.go:37: file: "/tmp/userdb_test1859981960" ---- PASS: TestWrite (0.38s) + userdb_test.go:37: file: "/tmp/userdb_test2599600923" +--- PASS: TestWrite (1.95s) === RUN TestNew ---- PASS: TestNew (0.06s) +--- PASS: TestNew (0.28s) === RUN TestInvalidUsername - userdb_test.go:37: file: "/tmp/userdb_test859864176" + userdb_test.go:37: file: "/tmp/userdb_test1172783673" --- PASS: TestInvalidUsername (0.00s) === RUN TestPlainScheme - userdb_test.go:37: file: "/tmp/userdb_test1202246156" ---- PASS: TestPlainScheme (0.00s) + userdb_test.go:37: file: "/tmp/userdb_test963641381" +--- PASS: TestPlainScheme (0.04s) === RUN TestDeniedScheme - userdb_test.go:37: file: "/tmp/userdb_test582274739" ---- PASS: TestDeniedScheme (0.00s) + userdb_test.go:37: file: "/tmp/userdb_test1167417727" +--- PASS: TestDeniedScheme (0.18s) === RUN TestReload - userdb_test.go:37: file: "/tmp/userdb_test554825342" ---- PASS: TestReload (0.00s) + userdb_test.go:37: file: "/tmp/userdb_test3486322727" +--- PASS: TestReload (0.35s) === RUN TestRemoveUser - userdb_test.go:37: file: "/tmp/userdb_test1806472003" ---- PASS: TestRemoveUser (0.05s) + userdb_test.go:37: file: "/tmp/userdb_test5968848" +--- PASS: TestRemoveUser (0.28s) === RUN TestExists - userdb_test.go:37: file: "/tmp/userdb_test319434144" ---- PASS: TestExists (0.05s) + userdb_test.go:37: file: "/tmp/userdb_test1720714155" +--- PASS: TestExists (0.24s) PASS -ok blitiri.com.ar/go/chasquid/internal/userdb 0.558s +ok blitiri.com.ar/go/chasquid/internal/userdb 3.365s create-stamp debian/debhelper-build-stamp dh_testroot -O--buildsystem=golang dh_prep -O--buildsystem=golang @@ -2501,12 +2530,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: not including original source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/426711/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/426711/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/1038988 and its subdirectories -I: Current time: Tue Jan 20 09:02:13 -12 2026 -I: pbuilder-time-stamp: 1768942933 +I: removing directory /srv/workspace/pbuilder/426711 and its subdirectories +I: Current time: Thu Dec 19 04:45:30 +14 2024 +I: pbuilder-time-stamp: 1734533130