Diff of the two buildlogs: -- --- b1/build.log 2024-06-05 05:11:12.828491727 +0000 +++ b2/build.log 2024-06-05 05:12:49.084402392 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Mon Jul 7 23:32:47 -12 2025 -I: pbuilder-time-stamp: 1751974367 +I: Current time: Wed Jul 9 01:34:15 +14 2025 +I: pbuilder-time-stamp: 1751974455 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/3535493/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/3279766/tmp/hooks/D01_modify_environment starting +debug: Running on codethink01-arm64. +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 Jul 8 11:34 /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/3279766/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/3279766/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='arm64' - DEBIAN_FRONTEND='noninteractive' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="21" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.2.21(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=arm64 + DEBIAN_FRONTEND=noninteractive DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=12 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - INVOCATION_ID='f3779b215d91407493da2120431be0d1' - 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='3535493' - PS1='# ' - PS2='> ' + INVOCATION_ID=e6268a02e14d4bf6a2f24ad369e4c836 + LANG=C + LANGUAGE=nl_BE:nl + LC_ALL=C + MACHTYPE=aarch64-unknown-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=3279766 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.33kK7oSy/pbuilderrc_N3Me --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.33kK7oSy/b1 --logfile b1/build.log chasquid_1.14.0-2.dsc' - SUDO_GID='109' - SUDO_UID='104' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://192.168.101.4: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.33kK7oSy/pbuilderrc_CJcS --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.33kK7oSy/b2 --logfile b2/build.log chasquid_1.14.0-2.dsc' + SUDO_GID=109 + SUDO_UID=104 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://192.168.101.4:3128 I: uname -a - Linux codethink03-arm64 6.1.0-21-cloud-arm64 #1 SMP Debian 6.1.90-1 (2024-05-03) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-21-cloud-arm64 #1 SMP Debian 6.1.90-1 (2024-05-03) aarch64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Jul 7 17:49 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/3535493/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Jul 5 17:47 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/3279766/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 arm64 golang-blitiri-go-log-dev all 1.1.0-1 [6724 B] Get: 44 http://deb.debian.org/debian trixie/main arm64 golang-blitiri-go-spf-dev all 1.5.1-1 [37.2 kB] Get: 45 http://deb.debian.org/debian trixie/main arm64 golang-blitiri-go-systemd-dev all 1.1.0-1 [6952 B] -Fetched 66.7 MB in 0s (142 MB/s) +Fetched 66.7 MB in 0s (189 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 ... 19743 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/3279766/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/3279766/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 @@ -391,76 +427,76 @@ 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-aarch64-linux-gnu && go install -trimpath -v -p 12 -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 +internal/goarch internal/goos -internal/unsafeheader -encoding +internal/godebugs internal/goexperiment +internal/unsafeheader unicode/utf8 -internal/itoa -internal/godebugs internal/coverage/rtcov -internal/goarch -runtime/internal/syscall -sync/atomic -internal/race -cmp -unicode +encoding internal/abi -internal/chacha8rand +internal/itoa +runtime/internal/math +runtime/internal/syscall math/bits internal/cpu -runtime/internal/math -log/internal runtime/internal/sys +internal/race +sync/atomic +unicode +cmp +log/internal +internal/chacha8rand internal/nettrace google.golang.org/protobuf/internal/flags unicode/utf16 container/ring +slices +math +google.golang.org/protobuf/internal/set container/list crypto/internal/alias crypto/subtle crypto/internal/boring/sig -math -slices -google.golang.org/protobuf/internal/set vendor/golang.org/x/crypto/cryptobyte/asn1 vendor/golang.org/x/crypto/internal/alias blitiri.com.ar/go/chasquid/internal/set -internal/bytealg runtime/internal/atomic +internal/bytealg runtime internal/reflectlite sync internal/testlog -internal/singleflight internal/bisect +internal/singleflight google.golang.org/protobuf/internal/pragma runtime/cgo +internal/godebug errors sort -internal/oserror -internal/godebug -vendor/golang.org/x/net/dns/dnsmessage strconv -internal/safefilepath io +strings path +internal/oserror +vendor/golang.org/x/net/dns/dnsmessage internal/intern math/rand -syscall +internal/safefilepath crypto/internal/nistec/fiat -golang.org/x/text/internal/tag -strings +reflect +syscall +net/netip crypto/internal/randutil +crypto/rc4 hash bytes -text/tabwriter +golang.org/x/text/internal/tag hash/fnv hash/crc32 -reflect -net/netip crypto -crypto/rc4 +text/tabwriter vendor/golang.org/x/text/transform golang.org/x/text/transform bufio @@ -473,73 +509,74 @@ internal/syscall/unix time internal/syscall/execenv +internal/fmtsort +encoding/binary io/fs internal/poll context -internal/fmtsort -encoding/binary -embed -google.golang.org/protobuf/internal/editiondefaults encoding/base64 -crypto/cipher crypto/internal/edwards25519/field vendor/golang.org/x/crypto/internal/poly1305 -crypto/internal/nistec crypto/md5 +crypto/cipher golang.org/x/sys/unix -os +embed encoding/pem +crypto/internal/edwards25519 crypto/internal/boring crypto/des vendor/golang.org/x/crypto/chacha20 -crypto/internal/edwards25519 +google.golang.org/protobuf/internal/editiondefaults +crypto/internal/nistec crypto/aes crypto/sha512 crypto/hmac crypto/sha1 crypto/sha256 +os vendor/golang.org/x/crypto/hkdf golang.org/x/crypto/pbkdf2 vendor/golang.org/x/crypto/chacha20poly1305 golang.org/x/crypto/scrypt crypto/ecdh fmt +net +io/ioutil google.golang.org/protobuf/internal/detrand blitiri.com.ar/go/chasquid/internal/safeio -io/ioutil -internal/sysinfo -os/signal internal/lazyregexp +os/signal +internal/sysinfo path/filepath -net os/exec -log flag +log google.golang.org/protobuf/internal/errors -go/token compress/flate google.golang.org/protobuf/internal/version -encoding/json -text/template/parse net/url +encoding/json math/big -google.golang.org/protobuf/encoding/protowire encoding/hex +text/template/parse +go/token +google.golang.org/protobuf/encoding/protowire +vendor/golang.org/x/text/unicode/norm google.golang.org/protobuf/reflect/protoreflect vendor/golang.org/x/text/unicode/bidi -vendor/golang.org/x/text/unicode/norm vendor/golang.org/x/net/http2/hpack mime mime/quotedprintable -net/http/internal compress/gzip +net/http/internal blitiri.com.ar/go/chasquid/internal/envelope golang.org/x/text/unicode/bidi golang.org/x/text/unicode/norm golang.org/x/text/internal/language -vendor/golang.org/x/text/secure/bidirule blitiri.com.ar/go/chasquid/internal/tlsconst +vendor/golang.org/x/text/secure/bidirule internal/profile +text/template runtime/pprof runtime/trace google.golang.org/protobuf/internal/encoding/messageset @@ -547,79 +584,78 @@ google.golang.org/protobuf/internal/genid google.golang.org/protobuf/internal/order google.golang.org/protobuf/reflect/protoregistry -google.golang.org/protobuf/internal/encoding/text google.golang.org/protobuf/runtime/protoiface google.golang.org/protobuf/internal/descfmt google.golang.org/protobuf/internal/descopts -text/template +google.golang.org/protobuf/internal/encoding/text vendor/golang.org/x/net/idna golang.org/x/text/secure/bidirule golang.org/x/text/internal/language/compact runtime/debug -golang.org/x/term google.golang.org/protobuf/proto golang.org/x/text/language -golang.org/x/net/idna -testing +golang.org/x/term +html/template google.golang.org/protobuf/internal/encoding/defval -google.golang.org/protobuf/encoding/prototext -google.golang.org/protobuf/internal/filedesc +golang.org/x/net/idna crypto/rand crypto/elliptic crypto/internal/bigmod crypto/internal/boring/bbig encoding/asn1 crypto/dsa -golang.org/x/text/internal +testing crypto/ed25519 -html/template +golang.org/x/text/internal golang.org/x/text/cases +google.golang.org/protobuf/encoding/prototext +google.golang.org/protobuf/internal/filedesc crypto/rsa -blitiri.com.ar/go/chasquid/internal/protoio vendor/golang.org/x/crypto/cryptobyte crypto/x509/pkix +blitiri.com.ar/go/chasquid/internal/protoio golang.org/x/text/secure/precis crypto/ecdsa -google.golang.org/protobuf/internal/encoding/tag blitiri.com.ar/go/chasquid/internal/normalize +google.golang.org/protobuf/internal/encoding/tag google.golang.org/protobuf/internal/impl log/syslog +crypto/x509 net/textproto -blitiri.com.ar/go/systemd +vendor/golang.org/x/net/http/httpproxy blitiri.com.ar/go/spf +blitiri.com.ar/go/systemd blitiri.com.ar/go/chasquid/internal/haproxy -vendor/golang.org/x/net/http/httpproxy -crypto/x509 blitiri.com.ar/go/log -google.golang.org/protobuf/internal/filetype vendor/golang.org/x/net/http/httpguts mime/multipart +blitiri.com.ar/go/chasquid/internal/dovecot net/mail blitiri.com.ar/go/chasquid/cmd/mda-lmtp -blitiri.com.ar/go/chasquid/internal/dovecot +google.golang.org/protobuf/internal/filetype +crypto/tls +blitiri.com.ar/go/chasquid/internal/dkim 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 -blitiri.com.ar/go/chasquid/internal/dkim -crypto/tls net/http/httptrace net/smtp blitiri.com.ar/go/chasquid/internal/testlib net/http blitiri.com.ar/go/chasquid/internal/smtp +blitiri.com.ar/go/chasquid/internal/nettrace 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/domaininfo blitiri.com.ar/go/chasquid/internal/localrpc -blitiri.com.ar/go/chasquid/internal/aliases -blitiri.com.ar/go/chasquid/internal/maillog blitiri.com.ar/go/chasquid/internal/auth +blitiri.com.ar/go/chasquid/internal/maillog 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 @@ -656,13 +692,13 @@ === RUN TestRichFile --- PASS: TestRichFile (0.00s) === RUN TestManyFiles ---- PASS: TestManyFiles (0.00s) +--- PASS: TestManyFiles (0.01s) === RUN TestHookError _ aliases.go:547 Hook.Alias-Resolve a@localA: error: exit status 1 _ 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.05s) +--- PASS: TestHookError (0.02s) === RUN FuzzReader === RUN FuzzReader/seed#0 === RUN FuzzReader/1c24d2215db69748c6fd16797673ad11ebc7e6167fe1bc1f54c6959ec10407b6 @@ -678,7 +714,7 @@ --- PASS: FuzzReader/c9c80ba9f513841cb081fe9bb7439d36f9f7a06bb999d4c39441991ccc878a9e (0.00s) --- PASS: FuzzReader/d40a98862ed393eb712e47a91bcef18e6f24cf368bb4bd248c7a7101ef8e178d (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/aliases 0.095s +ok blitiri.com.ar/go/chasquid/internal/aliases 0.078s === 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 @@ -691,11 +727,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.42s) +--- PASS: TestAuthenticate (0.32s) === RUN TestInterfaces --- PASS: TestInterfaces (0.00s) === RUN TestMultipleBackends ---- PASS: TestMultipleBackends (0.20s) +--- PASS: TestMultipleBackends (0.19s) === RUN TestErrors --- PASS: TestErrors (0.00s) === RUN TestReload @@ -724,28 +760,28 @@ --- PASS: FuzzDecodeResponse/d9aa9c617d1f5b3021aca758b9d896d136e3b16ed53233d02abffd02aa73ffa4 (0.00s) --- PASS: FuzzDecodeResponse/de05c7993312bab83e8114e9d9ced331c49822dc55c1a353f1cc9718a28226e7 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/auth 0.662s +ok blitiri.com.ar/go/chasquid/internal/auth 0.541s === RUN TestEmptyStruct --- PASS: TestEmptyStruct (0.00s) === RUN TestEmptyConfig - testlib.go:32: test directory: "/tmp/testlib_3304615637" + testlib.go:32: test directory: "/tmp/testlib_2284462911" --- PASS: TestEmptyConfig (0.00s) === RUN TestFullConfig - testlib.go:32: test directory: "/tmp/testlib_3024429176" + testlib.go:32: test directory: "/tmp/testlib_2944340922" --- PASS: TestFullConfig (0.00s) === RUN TestErrorLoading --- PASS: TestErrorLoading (0.00s) === RUN TestBrokenConfig - testlib.go:32: test directory: "/tmp/testlib_2626167848" + testlib.go:32: test directory: "/tmp/testlib_4157508515" --- PASS: TestBrokenConfig (0.00s) === RUN TestBrokenOverride - testlib.go:32: test directory: "/tmp/testlib_1846972237" + testlib.go:32: test directory: "/tmp/testlib_4093356634" --- PASS: TestBrokenOverride (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/config 0.050s +ok blitiri.com.ar/go/chasquid/internal/config 0.020s ? blitiri.com.ar/go/chasquid/internal/protoio/testpb [no test files] === RUN TestMDA - testlib.go:32: test directory: "/tmp/testlib_3431670608" + testlib.go:32: test directory: "/tmp/testlib_1189489556" --- PASS: TestMDA (0.03s) === RUN TestMDATimeout _ mda.go:73 Courier.MDA to@local: error: operation timed out @@ -753,17 +789,17 @@ === 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.08s) +--- PASS: TestMDABadCommandLine (0.01s) === 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_1948068583" - testlib.go:32: test directory: "/tmp/testlib_3753147112" -_ smtp.go:127 Courier.SMTP to@to: error: Could not dial: dial tcp: address ::::33367: too many colons in address -_ smtp.go:101 Courier.SMTP to@to: error: \":::\" returned transient error: Could not dial: dial tcp: address ::::33367: too many colons in address + testlib.go:32: test directory: "/tmp/testlib_293954511" + testlib.go:32: test directory: "/tmp/testlib_3962582604" +_ smtp.go:127 Courier.SMTP to@to: error: Could not dial: dial tcp: address ::::34609: too many colons in address +_ smtp.go:101 Courier.SMTP to@to: error: \":::\" returned transient error: Could not dial: dial tcp: address ::::34609: 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:" @@ -771,26 +807,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.06s) +--- PASS: TestSMTP (0.08s) === RUN TestSMTPErrors - testlib.go:32: test directory: "/tmp/testlib_2909325786" - testlib.go:32: test directory: "/tmp/testlib_256570706" + testlib.go:32: test directory: "/tmp/testlib_2881323033" + testlib.go:32: test directory: "/tmp/testlib_3869987605" fakeserver_test.go:98: fakeServer got connection -_ smtp.go:138 Courier.SMTP to@to: error: Error saying hello: write tcp 127.0.0.1:47620->127.0.0.1:34505: 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:47620->127.0.0.1:34505: 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:47620->127.0.0.1:34505: 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:47620->127.0.0.1:34505: i/o timeout) +_ smtp.go:138 Courier.SMTP to@to: error: Error saying hello: write tcp 127.0.0.1:33280->127.0.0.1:33259: 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:33280->127.0.0.1:33259: 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:33280->127.0.0.1:33259: 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:33280->127.0.0.1:33259: i/o timeout) fakeserver_test.go:105: fakeServer exiting: EOF - testlib.go:32: test directory: "/tmp/testlib_1033277243" - testlib.go:32: test directory: "/tmp/testlib_1230619461" + testlib.go:32: test directory: "/tmp/testlib_2540283650" + testlib.go:32: test directory: "/tmp/testlib_1363238966" 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_1832229060" - testlib.go:32: test directory: "/tmp/testlib_3634351456" + testlib.go:32: test directory: "/tmp/testlib_3346859341" + testlib.go:32: test directory: "/tmp/testlib_3118983733" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -798,8 +834,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_1495132365" - testlib.go:32: test directory: "/tmp/testlib_1467233512" + testlib.go:32: test directory: "/tmp/testlib_3848085679" + testlib.go:32: test directory: "/tmp/testlib_3792361765" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -808,8 +844,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_10025159" - testlib.go:32: test directory: "/tmp/testlib_1420148318" + testlib.go:32: test directory: "/tmp/testlib_2391918604" + testlib.go:32: test directory: "/tmp/testlib_2747712504" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -818,9 +854,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.33s) +--- PASS: TestSMTPErrors (1.22s) === RUN TestNoMXServer - testlib.go:32: test directory: "/tmp/testlib_3557582931" + testlib.go:32: test directory: "/tmp/testlib_3858791213" _ 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) @@ -835,8 +871,8 @@ === RUN TestLookupInvalidDomain --- PASS: TestLookupInvalidDomain (0.00s) === RUN TestTLS - testlib.go:32: test directory: "/tmp/testlib_282560562" - testlib.go:32: test directory: "/tmp/testlib_1288932089" + testlib.go:32: test directory: "/tmp/testlib_2687830442" + testlib.go:32: test directory: "/tmp/testlib_2734860223" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -847,7 +883,7 @@ fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF - testlib.go:32: test directory: "/tmp/testlib_4260221875" + testlib.go:32: test directory: "/tmp/testlib_2216475984" 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 @@ -855,10 +891,10 @@ _ smtp.go:101 Courier.SMTP to@to: error: \"localhost\" returned transient error: Security level check failed (level:PLAIN) _ smtp.go:105 Courier.SMTP to@to: error: all MXs returned transient failures (last: Security level check failed (level:PLAIN)) fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestTLS (0.19s) +--- PASS: TestTLS (0.11s) === RUN TestTLSError - testlib.go:32: test directory: "/tmp/testlib_3822545953" - testlib.go:32: test directory: "/tmp/testlib_2884249538" + testlib.go:32: test directory: "/tmp/testlib_1988222690" + testlib.go:32: test directory: "/tmp/testlib_603664437" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -871,10 +907,10 @@ fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestTLSError (0.04s) +--- PASS: TestTLSError (0.05s) === RUN TestSTSPolicyEnforcement - testlib.go:32: test directory: "/tmp/testlib_358313148" - testlib.go:32: test directory: "/tmp/testlib_629803415" + testlib.go:32: test directory: "/tmp/testlib_2455824797" + testlib.go:32: test directory: "/tmp/testlib_3106872422" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -882,7 +918,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_2716903315" + testlib.go:32: test directory: "/tmp/testlib_2862700646" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -893,9 +929,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.09s) +--- PASS: TestSTSPolicyEnforcement (0.13s) PASS -ok blitiri.com.ar/go/chasquid/internal/courier 1.980s +ok blitiri.com.ar/go/chasquid/internal/courier 1.790s === RUN TestStringToCanonicalization --- PASS: TestStringToCanonicalization (0.00s) === RUN TestSimpleBody @@ -911,7 +947,7 @@ === RUN TestTrace --- PASS: TestTrace (0.00s) === RUN TestLookupTXTNoCtx ---- PASS: TestLookupTXTNoCtx (0.00s) +--- PASS: TestLookupTXTNoCtx (0.01s) === RUN TestLookupTXT --- PASS: TestLookupTXT (0.00s) === RUN TestMaxHeaders @@ -931,7 +967,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:[0x400023bce0 0x400023bd40]} + file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0x4000217da0 0x4000217e00]} 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; @@ -975,7 +1011,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:[0x4000270540 0x40002705a0 0x4000270600 0x4000270660 0x40002706c0]} + file_test.go:56: Want result: &{Found:5 Valid:5 Results:[0x4000246600 0x4000246660 0x40002466c0 0x4000246720 0x4000246780]} 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; @@ -1087,7 +1123,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:[0x40002712c0]} + file_test.go:56: Want result: &{Found:1 Valid:0 Results:[0x4000247380]} 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; @@ -1101,7 +1137,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:[0x40002716e0 0x4000271740]} + file_test.go:56: Want result: &{Found:2 Valid:1 Results:[0x40002477a0 0x4000247800]} 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; @@ -1135,7 +1171,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:[0x4000271d40 0x4000271da0]} + file_test.go:56: Want result: &{Found:2 Valid:1 Results:[0x4000247e00 0x4000247e60]} 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; @@ -1169,7 +1205,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:[0x40002d4420 0x40002d4480]} + file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0x40002ae4e0 0x40002ae540]} 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; @@ -1216,7 +1252,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:[0x40002d4ba0 0x40002d4c00 0x40002d4c60]} + file_test.go:56: Want result: &{Found:3 Valid:3 Results:[0x40002aec60 0x40002aecc0 0x40002aed20]} 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; @@ -1276,7 +1312,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:[0x40002d5440 0x40002d54a0 0x40002d5500]} + file_test.go:56: Want result: &{Found:3 Valid:3 Results:[0x40002af500 0x40002af560 0x40002af5c0]} 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; @@ -1336,7 +1372,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:[0x40002d5ce0 0x40002d5d40]} + file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0x40002afda0 0x40002afe00]} 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; @@ -1382,7 +1418,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:[0x400034a480]} + file_test.go:56: Want result: &{Found:1 Valid:0 Results:[0x400031e540]} 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; @@ -1405,7 +1441,7 @@ context.go:17: Found 1 signatures, 0 valid --- PASS: TestFromFiles (0.02s) --- PASS: TestFromFiles/testdata/01-rfc8463 (0.00s) - --- PASS: TestFromFiles/testdata/02-too_many_headers (0.00s) + --- PASS: TestFromFiles/testdata/02-too_many_headers (0.01s) --- PASS: TestFromFiles/testdata/03-bad_message (0.00s) --- PASS: TestFromFiles/testdata/04-bad_dkim_signature_header (0.00s) --- PASS: TestFromFiles/testdata/05-dns_temp_error (0.00s) @@ -1438,18 +1474,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=1751974427; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "Zm5gqhi4c7wjJcY8Vz964m5ABgtXGqBqXsHa1tuDtNQ=" + context.go:17: Hashing header: "dkim-signature:v=1; a=rsa-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1751974522; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "LHCUazEE79PuY7ITYMyv1nEcV8Ky1iiNgHyLe3IsIlg=" context.go:17: Found DKIM-Signature header: v=1; a=rsa-sha256; c=relaxed/relaxed; - d=example.com; s=test; t=1751974427; + d=example.com; s=test; t=1751974522; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; - b=pGfxRY4UCioQpkVt/YhWWbbjux9XybIxabh9M2Ql0e30tNI+Xzs9SyUupSHm7tiwywvObc - GY5r9LBrQoMHe7QGVtaONme84RuKJRNuQzo/J6DA+Y65RUZDcLfswZxuIvIH4WWF54qbmm - YCaQzSTu9a9O0WDpRwEKGJbVrh+V1hZcJ9aGuuxFFjxqRvw2hfl9hLKjxunjQRnBS+cg5P - +SEZDy6z8hLs59puTYU6WxU1yv1W8X/kHY24Ln4XCIgtGzdWhoYn5VUbx3FTJyUlcW4uXt - VlrHbX39WnTb/W0SzDdNf+f26QbP0bsJkcTEhzUJ47uZ/CMBoIlhmJqZ+PfJnQ==; - context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; p=MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAsuuMOnE1ZAulj9wAu2PfFzpM2pVxgf1yADAgD/e8aow3MXXxxU++9CIScH0MC+TWeG0mMHKx4TQPO/262FAktne873j3AgW70MMl1mROcOrWlCgpxEMoO3h955BFCon8AJm7Fdgcwnv/Hxm8ZWU2byKtbyr3drsObEWhqHD4RPsZfBvI5biMNclK10qagUtoK5ARnnryLPs7SeNm1Jle7ZfmDUQnLvkBOjOgP8kwMdKbRLKGkgNpz6Ca/9g41g2LUkDiuk7g28FXCivNoV/ELLkY6iFWo7KoLrD+gw1Og6fpY8yUmlTpzu0gahH1K626tTfzNm5B5v9xcPDY+/yOcwIDAQAB" + b=kNocpA4MYK6sE+/sVjFFjbb4jVaKfi+MCd8DW8qVlCKxCWnvnOVkdk3YOZPRJQq8rjAAhK + 0lDjij/+VJuBAUYlwz1ptsjtA4eg2wgCVMEdFSs4bpe3hnUuuryAFwQKmtY0E715aRCuhz + ySL+RJcov567+3Yr4f7Oqh3EYDjtK9m4Qst41GSHSq2TYm/CAkKdd8AI0peHiWxrDxkr+U + nguIeEUOSLnQP2TxZ2BAj0ArNVrZDhCVXuiqmSAkGpbjmd094weTrZ9AmqrrOWBH+7O7VV + +6Rc1WF7DJh+6lRpLBhjRsV47GqDWWuYrGww9Gs5pByYLVlWIrP7FB5zhuUbPA==; + context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; p=MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAwMiwXi+qeGcZdw2KBlqfYaaCpc3k1E2xLqMg4ab+j75+JlQ5sFmxfUAiK80rn4tS9/y1sMhlXTDsuzGdQjcYdXBpAFSopJyncyCMlJ65YFfXajcCHlMwM4NtfR3+xA6/QRQ/UvQkmubN/GtP814TNiYNq367mu6CAq31EPLHPW/ctDwyV1l6K0kG21TXcOebMVY508nAfKbxfp0OaIW0z5Oo5grloeLHNk3UqEcUFdonwKhP/UY9fdkx96flDK4mMsJCAKdPGPYPSan0uFpcfThD1LMilGcnPlZ+E/Sh7jSEa7pSQ/zyS1t5HW+Pu5xdguJaYdW2eAEGTyuf3ioW4QIDAQAB" 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" @@ -1457,11 +1493,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=1751974427; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "Zm5gqhi4c7wjJcY8Vz964m5ABgtXGqBqXsHa1tuDtNQ=" + context.go:17: Hashing header: "dkim-signature:v=1; a=rsa-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1751974522; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "LHCUazEE79PuY7ITYMyv1nEcV8Ky1iiNgHyLe3IsIlg=" context.go:17: PK [rsa:30820122300d0609]: Verification succeeded context.go:17: Found 1 signatures, 1 valid ---- PASS: TestSignRSA (0.25s) +--- PASS: TestSignRSA (1.02s) === RUN TestSignEd25519 context.go:17: Signing for example.com / test with ed25519-sha256 context.go:17: Hashing header: "from:Joe SixPack \r\n" @@ -1469,27 +1505,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=1751974427; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "5lSXplnBQDZuPYwKN8YVHeQ9eRsIXNmk9Zd6av994JE=" + context.go:17: Hashing header: "dkim-signature:v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1751974522; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "48eu2hTLlxFuJoe8FMOSuseGLdB6g/X9K1IhI9+fVRg=" context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; - d=example.com; s=test; t=1751974427; + d=example.com; s=test; t=1751974522; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; - b=BmqnMQIhuga4B06fPpRp2NeV6doDr1pfH9TRKkSsVB730hniCT5TpmRm2aQMO55nShFUhe - 7WFKjjMnr5ExdXCw==; - context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; k=ed25519; p=JqksIiRKBhlbPR+U4M0EzAMqMRMLvpikeiADjqzMXg4=" - context.go:17: Parsed public key: [ed25519:26a92c22244a0619] + b=uVeQJZ1ATxs/M2+z0EWu/VkCUjk0yw7ofUjEt5ua0Yt+tiW0Tiy9hV1rJLkIwV2U/xZQA0 + ndzVdJKr3ogbyLBQ==; + context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; k=ed25519; p=FEo9vfgBF17+f6QY39H5ecO4lX5Jg6L/064nMG1bWu0=" + context.go:17: Parsed public key: [ed25519:144a3dbdf801175e] 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=1751974427; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "5lSXplnBQDZuPYwKN8YVHeQ9eRsIXNmk9Zd6av994JE=" - context.go:17: PK [ed25519:26a92c22244a0619]: Verification succeeded + context.go:17: Hashing header: "dkim-signature:v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1751974522; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "48eu2hTLlxFuJoe8FMOSuseGLdB6g/X9K1IhI9+fVRg=" + context.go:17: PK [ed25519:144a3dbdf801175e]: Verification succeeded context.go:17: Found 1 signatures, 1 valid ---- PASS: TestSignEd25519 (0.00s) +--- PASS: TestSignEd25519 (0.01s) === RUN TestSignBadMessage --- PASS: TestSignBadMessage (0.00s) === RUN TestSignBadAlgorithm @@ -1686,9 +1722,9 @@ --- PASS: FuzzParsePublicKey/seed#12 (0.00s) --- PASS: FuzzParsePublicKey/seed#13 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/dkim 0.312s +ok blitiri.com.ar/go/chasquid/internal/dkim 1.091s === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_2202328503" + testlib.go:32: test directory: "/tmp/testlib_979462125" _ 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 @@ -1697,14 +1733,14 @@ _ domaininfo.go:182 DomainInfo.SetToPlain d1: set to plain --- PASS: TestBasic (0.00s) === RUN TestNewDomain - testlib.go:32: test directory: "/tmp/testlib_2729160078" + testlib.go:32: test directory: "/tmp/testlib_3474626329" _ 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) === RUN TestProgressions - testlib.go:32: test directory: "/tmp/testlib_3516785848" + testlib.go:32: test directory: "/tmp/testlib_554220226" _ 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 @@ -1719,27 +1755,27 @@ _ domaininfo.go:145 DomainInfo.Outgoing ssip: error: ssip outgoing denied: PLAIN < TLS_SECURE --- PASS: TestProgressions (0.00s) === RUN TestErrors - testlib.go:32: test directory: "/tmp/testlib_3491865578" + testlib.go:32: test directory: "/tmp/testlib_128482784" _ domaininfo.go:117 DomainInfo.Incoming d1: d1 incoming level raised: TLS_SECURE > PLAIN _ domaininfo.go:67 DomainInfo.Reload reload: error: id \"d1\": proto:\u00a0syntax error (line 1:1): invalid field name: invalid-text-protobuf-contents _ domaininfo.go:67 DomainInfo.Reload reload: error: id \"d1\": proto:\u00a0syntax error (line 1:1): invalid field name: invalid-text-protobuf-contents --- PASS: TestErrors (0.00s) === RUN TestDirectoryErrors - testlib.go:32: test directory: "/tmp/testlib_3255852521" -_ domaininfo.go:59 DomainInfo.Reload reload: error: open /tmp/testlib_3255852521/db: no such file or directory -_ domaininfo.go:84 DomainInfo.write d1: error: open /tmp/testlib_3255852521/db/.s:d11395550082: no such file or directory + testlib.go:32: test directory: "/tmp/testlib_2129656105" +_ domaininfo.go:59 DomainInfo.Reload reload: error: open /tmp/testlib_2129656105/db: no such file or directory +_ domaininfo.go:84 DomainInfo.write d1: error: open /tmp/testlib_2129656105/db/.s:d13228351813: no such file or directory --- PASS: TestDirectoryErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/domaininfo 0.029s +ok blitiri.com.ar/go/chasquid/internal/domaininfo 0.048s === RUN TestUsernameNotSafe --- PASS: TestUsernameNotSafe (0.00s) === RUN TestAutodetect - testlib.go:32: test directory: "/tmp/testlib_3194562094" + testlib.go:32: test directory: "/tmp/testlib_1088840116" --- PASS: TestAutodetect (0.00s) === RUN TestReload --- PASS: TestReload (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/dovecot 0.048s +ok blitiri.com.ar/go/chasquid/internal/dovecot 0.044s === RUN TestSplit --- PASS: TestSplit (0.00s) === RUN TestDomainIn @@ -1747,13 +1783,13 @@ === RUN TestAddHeader --- PASS: TestAddHeader (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/envelope 0.036s +ok blitiri.com.ar/go/chasquid/internal/envelope 0.032s === RUN TestHandler --- PASS: TestHandler (0.00s) === RUN TestMapLabelAccident --- PASS: TestMapLabelAccident (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/expvarom 0.013s +ok blitiri.com.ar/go/chasquid/internal/expvarom 0.039s === RUN TestNoNewline --- PASS: TestNoNewline (0.00s) === RUN TestBasic @@ -1778,21 +1814,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.012s +ok blitiri.com.ar/go/chasquid/internal/haproxy 0.021s === RUN TestBadServer - asm_arm64.s:1222: FakeServer &{{0x4000206480}}: accepted - asm_arm64.s:1222: FakeServer &{{0x4000206480}}: readRequest: "" "" / EOF - asm_arm64.s:1222: FakeServer &{{0x4000206480}}: writeMessage("xxx"): 0 write unix /tmp/rpc-test-256536671/rpc.sock->@: write: broken pipe - asm_arm64.s:1222: FakeServer &{{0x4000206480}}: closing - asm_arm64.s:1222: FakeServer &{{0x4000206600}}: accepted - asm_arm64.s:1222: FakeServer &{{0x4000206600}}: readRequest: "Echo" "" / - asm_arm64.s:1222: FakeServer &{{0x4000206600}}: writeMessage("xxx"): 3 - asm_arm64.s:1222: FakeServer &{{0x4000206600}}: closing ---- PASS: TestBadServer (0.02s) + asm_arm64.s:1222: FakeServer &{{0x40001d0d80}}: accepted + asm_arm64.s:1222: FakeServer &{{0x40001d0d80}}: readRequest: "" "" / EOF + asm_arm64.s:1222: FakeServer &{{0x40001d0d80}}: writeMessage("xxx"): 0 write unix /tmp/rpc-test-1291540581/rpc.sock->@: write: broken pipe + asm_arm64.s:1222: FakeServer &{{0x40001d0d80}}: closing + asm_arm64.s:1222: FakeServer &{{0x40001d0f00}}: accepted + asm_arm64.s:1222: FakeServer &{{0x40001d0f00}}: readRequest: "Echo" "" / + asm_arm64.s:1222: FakeServer &{{0x40001d0f00}}: writeMessage("xxx"): 3 + asm_arm64.s:1222: FakeServer &{{0x40001d0f00}}: closing +--- PASS: TestBadServer (0.01s) === RUN TestBadSocket --- PASS: TestBadSocket (0.00s) === RUN TestEndToEnd -_ localrpc.go:63 LocalRPC.Server /tmp/rpc-test-3622647369/sock: Listening +_ localrpc.go:63 LocalRPC.Server /tmp/rpc-test-3340676397/sock: Listening === RUN TestEndToEnd/Echo === RUN TestEndToEnd/Echo#01 === RUN TestEndToEnd/Hola @@ -1800,7 +1836,7 @@ _ localrpc.go:139 LocalRPC.Handle @: error: -> 500 test error === RUN TestEndToEnd/UnknownMethod _ localrpc.go:139 LocalRPC.Handle @: error: -> 500 unknown method -_ localrpc.go:67 LocalRPC.Server /tmp/rpc-test-3622647369/sock: error: Accept error: accept unix /tmp/rpc-test-3622647369/sock: use of closed network connection +_ localrpc.go:67 LocalRPC.Server /tmp/rpc-test-3340676397/sock: error: Accept error: accept unix /tmp/rpc-test-3340676397/sock: use of closed network connection --- PASS: TestEndToEnd (0.01s) --- PASS: TestEndToEnd/Echo (0.00s) --- PASS: TestEndToEnd/Echo#01 (0.00s) @@ -1815,7 +1851,7 @@ === RUN TestShortReadRequest --- PASS: TestShortReadRequest (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/localrpc 0.080s +ok blitiri.com.ar/go/chasquid/internal/localrpc 0.048s === RUN TestLogger --- PASS: TestLogger (0.00s) === RUN TestDefault @@ -1823,7 +1859,7 @@ === RUN TestFailedLogger --- PASS: TestFailedLogger (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/maillog 0.045s +ok blitiri.com.ar/go/chasquid/internal/maillog 0.020s === RUN TestContext --- PASS: TestContext (0.00s) === RUN TestHistogramBasic @@ -1835,11 +1871,11 @@ === RUN TestHTTPLong --- PASS: TestHTTPLong (0.00s) === RUN TestHTTPErrors ---- PASS: TestHTTPErrors (0.09s) +--- PASS: TestHTTPErrors (0.03s) === RUN TestHTTPUroboro ---- PASS: TestHTTPUroboro (0.00s) +--- PASS: TestHTTPUroboro (0.01s) === RUN TestHTTPDeep ---- PASS: TestHTTPDeep (0.01s) +--- PASS: TestHTTPDeep (0.00s) === RUN TestStripZeros --- PASS: TestStripZeros (0.00s) === RUN TestRegisterHandler @@ -1859,7 +1895,7 @@ === RUN TestFindParent --- PASS: TestFindParent (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/nettrace 0.156s +ok blitiri.com.ar/go/chasquid/internal/nettrace 0.074s === RUN TestUser --- PASS: TestUser (0.00s) === RUN TestDomain @@ -1919,40 +1955,40 @@ --- PASS: FuzzDomainToUnicode/d8637022b61fb5c4df4e153063564accd6331debaafdd594405c320a5e9f2e70 (0.00s) --- PASS: FuzzDomainToUnicode/dc0204d8e2ab058a763873d2a5fede806e95235771ecdd96b56c906886822c19 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/normalize 0.037s +ok blitiri.com.ar/go/chasquid/internal/normalize 0.028s === RUN TestBin - testlib.go:32: test directory: "/tmp/testlib_2465350661" + testlib.go:32: test directory: "/tmp/testlib_3024846639" --- PASS: TestBin (0.00s) === RUN TestText - testlib.go:32: test directory: "/tmp/testlib_2025988206" + testlib.go:32: test directory: "/tmp/testlib_2366471079" --- PASS: TestText (0.00s) === RUN TestStore - testlib.go:32: test directory: "/tmp/testlib_652984042" + testlib.go:32: test directory: "/tmp/testlib_1841844400" --- PASS: TestStore (0.00s) === RUN TestFileErrors - testlib.go:32: test directory: "/tmp/testlib_1651355308" + testlib.go:32: test directory: "/tmp/testlib_4262480469" --- PASS: TestFileErrors (0.00s) === RUN TestMarshalErrors - testlib.go:32: test directory: "/tmp/testlib_298727103" + testlib.go:32: test directory: "/tmp/testlib_1888635197" --- PASS: TestMarshalErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/protoio 0.053s +ok blitiri.com.ar/go/chasquid/internal/protoio 0.015s === RUN TestDSN dsn_test.go:49: From: Mail Delivery System To: Subject: Mail delivery failed: returning message to sender - Message-ID: - Date: Tue, 08 Jul 2025 11:33:48 +0000 + Message-ID: + Date: Tue, 08 Jul 2025 11:35:23 +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="TZzYoypuNTA" + boundary="sgKJrCEI5I8" - --TZzYoypuNTA + --sgKJrCEI5I8 Content-Type: text/plain; charset="utf-8" Content-Disposition: inline Content-Description: Notification @@ -1977,7 +2013,7 @@ oh! the humanity! - --TZzYoypuNTA + --sgKJrCEI5I8 Content-Type: message/global-delivery-status Content-Description: Delivery Report Content-Transfer-Encoding: 8bit @@ -2008,7 +2044,7 @@ - --TZzYoypuNTA + --sgKJrCEI5I8 Content-Type: message/rfc822 Content-Description: Undelivered Message Content-Transfer-Encoding: 8bit @@ -2018,76 +2054,76 @@ Data ñaca. - --TZzYoypuNTA-- + --sgKJrCEI5I8-- --- PASS: TestDSN (0.00s) === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_782242868" -_ queue.go:308 Queue.SendLoop bSjkhGk5_NI: from from -_ queue.go:367 Queue.SendLoop bSjkhGk5_NI: nodomain sent -_ queue.go:367 Queue.SendLoop bSjkhGk5_NI: am@loco sent -_ queue.go:367 Queue.SendLoop bSjkhGk5_NI: x@remote sent -_ queue.go:342 Queue.SendLoop bSjkhGk5_NI: all done ---- PASS: TestBasic (0.00s) + testlib.go:32: test directory: "/tmp/testlib_2471691571" +_ queue.go:308 Queue.SendLoop suUhv5_tPmE: from from +_ queue.go:367 Queue.SendLoop suUhv5_tPmE: nodomain sent +_ queue.go:367 Queue.SendLoop suUhv5_tPmE: am@loco sent +_ queue.go:367 Queue.SendLoop suUhv5_tPmE: x@remote sent +_ queue.go:342 Queue.SendLoop suUhv5_tPmE: all done +--- PASS: TestBasic (0.02s) === RUN TestDSNOnTimeout - testlib.go:32: test directory: "/tmp/testlib_2115214772" -_ queue.go:308 Queue.SendLoop yAR1b1dAQB4: from from@loco -_ queue.go:467 Queue.SendLoop yAR1b1dAQB4: queued DSN: jOgdlCxqaAg -_ queue.go:342 Queue.SendLoop yAR1b1dAQB4: all done -_ queue.go:308 Queue.SendLoop jOgdlCxqaAg: from <> -_ queue.go:367 Queue.SendLoop jOgdlCxqaAg: from@loco sent -_ queue.go:342 Queue.SendLoop jOgdlCxqaAg: all done + testlib.go:32: test directory: "/tmp/testlib_1356173337" +_ queue.go:308 Queue.SendLoop om8xcC1QorM: from from@loco +_ queue.go:467 Queue.SendLoop om8xcC1QorM: queued DSN: VYpkEoR9ajY +_ queue.go:342 Queue.SendLoop om8xcC1QorM: all done +_ queue.go:308 Queue.SendLoop VYpkEoR9ajY: from <> +_ queue.go:367 Queue.SendLoop VYpkEoR9ajY: from@loco sent +_ queue.go:342 Queue.SendLoop VYpkEoR9ajY: all done --- PASS: TestDSNOnTimeout (0.00s) === RUN TestAliases - testlib.go:32: test directory: "/tmp/testlib_33005354" -_ queue.go:308 Queue.SendLoop BQQe_hz72Lc: from from -_ queue.go:367 Queue.SendLoop BQQe_hz72Lc: ata@hualpa sent -_ queue.go:367 Queue.SendLoop BQQe_hz72Lc: pq@loco sent -_ queue.go:367 Queue.SendLoop BQQe_hz72Lc: rs@loco sent -_ queue.go:342 Queue.SendLoop BQQe_hz72Lc: all done + testlib.go:32: test directory: "/tmp/testlib_4275515622" +_ queue.go:308 Queue.SendLoop tdlPjewLpCQ: from from +_ queue.go:367 Queue.SendLoop tdlPjewLpCQ: ata@hualpa sent +_ queue.go:367 Queue.SendLoop tdlPjewLpCQ: pq@loco sent +_ queue.go:367 Queue.SendLoop tdlPjewLpCQ: rs@loco sent +_ queue.go:342 Queue.SendLoop tdlPjewLpCQ: all done --- PASS: TestAliases (0.00s) === RUN TestFullQueue - testlib.go:32: test directory: "/tmp/testlib_3372398815" + testlib.go:32: test directory: "/tmp/testlib_1969999501" _ queue.go:164 Queue.Put from: error: queue full --- PASS: TestFullQueue (0.00s) === RUN TestPipes - testlib.go:32: test directory: "/tmp/testlib_2532158308" -_ queue.go:308 Queue.SendLoop 8Q8n3YQOeaM: from from -_ queue.go:367 Queue.SendLoop 8Q8n3YQOeaM: to sent -_ queue.go:375 Queue.SendLoop 8Q8n3YQOeaM: error: failed to write: open /tmp/testlib_3372398815/.m:8Q8n3YQOeaM653778516: no such file or directory -_ queue.go:342 Queue.SendLoop 8Q8n3YQOeaM: all done -E queue.go:230 failed to remove queue file "/tmp/testlib_3372398815/m:8Q8n3YQOeaM": remove /tmp/testlib_3372398815/m:8Q8n3YQOeaM: no such file or directory ---- PASS: TestPipes (0.00s) + testlib.go:32: test directory: "/tmp/testlib_3151187162" +_ queue.go:308 Queue.SendLoop 3kDe3o8zjo0: from from +_ queue.go:367 Queue.SendLoop 3kDe3o8zjo0: to sent +_ queue.go:375 Queue.SendLoop 3kDe3o8zjo0: error: failed to write: open /tmp/testlib_1969999501/.m:3kDe3o8zjo03960568412: no such file or directory +_ queue.go:342 Queue.SendLoop 3kDe3o8zjo0: all done +E queue.go:230 failed to remove queue file "/tmp/testlib_1969999501/m:3kDe3o8zjo0": remove /tmp/testlib_1969999501/m:3kDe3o8zjo0: no such file or directory +--- PASS: TestPipes (0.01s) === RUN TestBadPath --- PASS: TestBadPath (0.00s) === RUN TestNextDelay --- PASS: TestNextDelay (0.00s) === RUN TestSerialization - testlib.go:32: test directory: "/tmp/testlib_2605948468" -_ queue.go:308 Queue.SendLoop F8s1BFLEkQQ: from from@loco -_ queue.go:367 Queue.SendLoop F8s1BFLEkQQ: to@to sent -_ queue.go:342 Queue.SendLoop F8s1BFLEkQQ: all done + testlib.go:32: test directory: "/tmp/testlib_4151783738" +_ queue.go:308 Queue.SendLoop 6VFKwISTbNQ: from from@loco +_ queue.go:367 Queue.SendLoop 6VFKwISTbNQ: to@to sent +_ queue.go:342 Queue.SendLoop 6VFKwISTbNQ: all done --- PASS: TestSerialization (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/queue 0.042s +ok blitiri.com.ar/go/chasquid/internal/queue 0.061s === RUN TestWriteFile - testlib.go:32: test directory: "/tmp/testlib_1813525792" + testlib.go:32: test directory: "/tmp/testlib_563868649" --- PASS: TestWriteFile (0.00s) === RUN TestWriteFileWithOp - testlib.go:32: test directory: "/tmp/testlib_1281218611" + testlib.go:32: test directory: "/tmp/testlib_988890592" --- PASS: TestWriteFileWithOp (0.00s) === RUN TestWriteFileWithFailingOp - testlib.go:32: test directory: "/tmp/testlib_1858909757" + testlib.go:32: test directory: "/tmp/testlib_1301604336" --- PASS: TestWriteFileWithFailingOp (0.00s) === RUN TestErrors - testlib.go:32: test directory: "/tmp/testlib_1835809817" + testlib.go:32: test directory: "/tmp/testlib_1235182905" --- PASS: TestErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/safeio 0.025s +ok blitiri.com.ar/go/chasquid/internal/safeio 0.015s === RUN TestString --- PASS: TestString (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/set 0.033s +ok blitiri.com.ar/go/chasquid/internal/set 0.016s === RUN TestIsPermanent --- PASS: TestIsPermanent (0.00s) === RUN TestIsASCII @@ -2101,16 +2137,16 @@ === RUN TestFallbackToIDNA --- PASS: TestFallbackToIDNA (0.00s) === RUN TestLineTooLong ---- PASS: TestLineTooLong (0.08s) +--- PASS: TestLineTooLong (0.03s) PASS -ok blitiri.com.ar/go/chasquid/internal/smtp 0.122s +ok blitiri.com.ar/go/chasquid/internal/smtp 0.040s ? blitiri.com.ar/go/chasquid/internal/trace [no test files] -_ server.go:296 Server listening on 127.0.0.1:40753 (submission+TLS) -2025-07-08 11:33:49.992355 daemon listening on 127.0.0.1:40753 -_ server.go:296 Server listening on 127.0.0.1:45581 (SMTP) -2025-07-08 11:33:49.992428 daemon listening on 127.0.0.1:45581 -_ server.go:296 Server listening on 127.0.0.1:41281 (submission) -2025-07-08 11:33:49.992445 daemon listening on 127.0.0.1:41281 +_ server.go:296 Server listening on 127.0.0.1:34121 (SMTP) +2025-07-08 11:35:23.877273 daemon listening on 127.0.0.1:34121 +_ server.go:296 Server listening on 127.0.0.1:35931 (submission) +2025-07-08 11:35:23.877346 daemon listening on 127.0.0.1:35931 +_ server.go:296 Server listening on 127.0.0.1:40991 (submission+TLS) +2025-07-08 11:35:23.877364 daemon listening on 127.0.0.1:40991 === RUN TestSecLevel _ 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 @@ -2127,183 +2163,183 @@ === RUN TestReadUntilDotReadError --- PASS: TestReadUntilDotReadError (0.00s) === RUN TestSimple -_ conn.go:209 SMTP.Conn 127.0.0.1:42204: error: error completing TLS handshake: EOF -_ conn.go:722 SMTP.Conn 127.0.0.1:46992: Queued from from@from to [to@localhost] - ifZsrynOLY8 -2025-07-08 11:33:50.096271 ifZsrynOLY8 from=from@from queued ip=127.0.0.1:46992 to=[to@localhost] -_ queue.go:308 Queue.SendLoop ifZsrynOLY8: from from@from -_ queue.go:367 Queue.SendLoop ifZsrynOLY8: testuser@localhost sent -2025-07-08 11:33:50.096361 ifZsrynOLY8 from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop ifZsrynOLY8: all done -2025-07-08 11:33:50.096556 ifZsrynOLY8 from=from@from all done +_ conn.go:209 SMTP.Conn 127.0.0.1:34684: error: error completing TLS handshake: EOF +_ conn.go:722 SMTP.Conn 127.0.0.1:43138: Queued from from@from to [to@localhost] - m085D6AeCQM +2025-07-08 11:35:23.981646 m085D6AeCQM from=from@from queued ip=127.0.0.1:43138 to=[to@localhost] +_ queue.go:308 Queue.SendLoop m085D6AeCQM: from from@from +_ queue.go:367 Queue.SendLoop m085D6AeCQM: testuser@localhost sent +2025-07-08 11:35:23.981745 m085D6AeCQM from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop m085D6AeCQM: all done +2025-07-08 11:35:23.981943 m085D6AeCQM from=from@from all done --- PASS: TestSimple (0.00s) === RUN TestSimpleTLS -_ conn.go:722 SMTP.Conn 127.0.0.1:46994: Queued from from@from to [to@localhost] - YheJv70KEHg -2025-07-08 11:33:50.102425 YheJv70KEHg from=from@from queued ip=127.0.0.1:46994 to=[to@localhost] -_ queue.go:308 Queue.SendLoop YheJv70KEHg: from from@from -_ queue.go:367 Queue.SendLoop YheJv70KEHg: testuser@localhost sent -2025-07-08 11:33:50.102506 YheJv70KEHg from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop YheJv70KEHg: all done -2025-07-08 11:33:50.102601 YheJv70KEHg from=from@from all done ---- PASS: TestSimpleTLS (0.01s) +_ conn.go:722 SMTP.Conn 127.0.0.1:43150: Queued from from@from to [to@localhost] - gAQTWiJo5g0 +2025-07-08 11:35:23.984589 gAQTWiJo5g0 from=from@from queued ip=127.0.0.1:43150 to=[to@localhost] +_ queue.go:308 Queue.SendLoop gAQTWiJo5g0: from from@from +_ queue.go:367 Queue.SendLoop gAQTWiJo5g0: testuser@localhost sent +2025-07-08 11:35:23.984677 gAQTWiJo5g0 from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop gAQTWiJo5g0: all done +2025-07-08 11:35:23.984772 gAQTWiJo5g0 from=from@from all done +--- PASS: TestSimpleTLS (0.00s) === RUN TestManyEmails -_ conn.go:722 SMTP.Conn 127.0.0.1:47010: Queued from from@from to [to@localhost] - L_Elf7eBeFY -2025-07-08 11:33:50.104939 L_Elf7eBeFY from=from@from queued ip=127.0.0.1:47010 to=[to@localhost] -_ queue.go:308 Queue.SendLoop L_Elf7eBeFY: from from@from -_ queue.go:367 Queue.SendLoop L_Elf7eBeFY: testuser@localhost sent -2025-07-08 11:33:50.105005 L_Elf7eBeFY from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop L_Elf7eBeFY: all done -2025-07-08 11:33:50.105092 L_Elf7eBeFY from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:47010: Queued from from@from to [to@localhost] - RTNYCHzfzak -2025-07-08 11:33:50.105408 RTNYCHzfzak from=from@from queued ip=127.0.0.1:47010 to=[to@localhost] -_ queue.go:308 Queue.SendLoop RTNYCHzfzak: from from@from -_ queue.go:367 Queue.SendLoop RTNYCHzfzak: testuser@localhost sent -2025-07-08 11:33:50.105534 RTNYCHzfzak from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop RTNYCHzfzak: all done -2025-07-08 11:33:50.105623 RTNYCHzfzak from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:47010: Queued from from@from to [to@localhost] - jtLkjog0xIw -2025-07-08 11:33:50.109946 jtLkjog0xIw from=from@from queued ip=127.0.0.1:47010 to=[to@localhost] -_ queue.go:308 Queue.SendLoop jtLkjog0xIw: from from@from -_ queue.go:367 Queue.SendLoop jtLkjog0xIw: testuser@localhost sent -2025-07-08 11:33:50.110023 jtLkjog0xIw from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop jtLkjog0xIw: all done -2025-07-08 11:33:50.110117 jtLkjog0xIw from=from@from all done ---- PASS: TestManyEmails (0.01s) +_ conn.go:722 SMTP.Conn 127.0.0.1:43164: Queued from from@from to [to@localhost] - NQY0S-MegQE +2025-07-08 11:35:23.987351 NQY0S-MegQE from=from@from queued ip=127.0.0.1:43164 to=[to@localhost] +_ queue.go:308 Queue.SendLoop NQY0S-MegQE: from from@from +_ queue.go:367 Queue.SendLoop NQY0S-MegQE: testuser@localhost sent +2025-07-08 11:35:23.987428 NQY0S-MegQE from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop NQY0S-MegQE: all done +2025-07-08 11:35:23.987523 NQY0S-MegQE from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:43164: Queued from from@from to [to@localhost] - SJjJ9yanmvw +2025-07-08 11:35:23.987820 SJjJ9yanmvw from=from@from queued ip=127.0.0.1:43164 to=[to@localhost] +_ queue.go:308 Queue.SendLoop SJjJ9yanmvw: from from@from +_ queue.go:367 Queue.SendLoop SJjJ9yanmvw: testuser@localhost sent +2025-07-08 11:35:23.987877 SJjJ9yanmvw from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop SJjJ9yanmvw: all done +2025-07-08 11:35:23.987949 SJjJ9yanmvw from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:43164: Queued from from@from to [to@localhost] - iAjWkTTxSPE +2025-07-08 11:35:23.988208 iAjWkTTxSPE from=from@from queued ip=127.0.0.1:43164 to=[to@localhost] +_ queue.go:308 Queue.SendLoop iAjWkTTxSPE: from from@from +_ queue.go:367 Queue.SendLoop iAjWkTTxSPE: testuser@localhost sent +2025-07-08 11:35:23.988255 iAjWkTTxSPE from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop iAjWkTTxSPE: all done +2025-07-08 11:35:23.988328 iAjWkTTxSPE from=from@from all done +--- PASS: TestManyEmails (0.00s) === RUN TestAuth -2025-07-08 11:33:50.213530 127.0.0.1:54948 auth succeeded for testuser@localhost -_ conn.go:722 SMTP.Conn 127.0.0.1:54948: Queued from testuser@localhost to [to@localhost] - cW5skcCs1G4 -2025-07-08 11:33:50.214054 cW5skcCs1G4 from=testuser@localhost queued ip=127.0.0.1:54948 to=[to@localhost] -_ queue.go:308 Queue.SendLoop cW5skcCs1G4: from testuser@localhost -_ queue.go:367 Queue.SendLoop cW5skcCs1G4: testuser@localhost sent -2025-07-08 11:33:50.214120 cW5skcCs1G4 from=testuser@localhost to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop cW5skcCs1G4: all done -2025-07-08 11:33:50.214215 cW5skcCs1G4 from=testuser@localhost all done ---- PASS: TestAuth (0.10s) +2025-07-08 11:35:24.098522 127.0.0.1:59796 auth succeeded for testuser@localhost +_ conn.go:722 SMTP.Conn 127.0.0.1:59796: Queued from testuser@localhost to [to@localhost] - n8ZnFFFtORU +2025-07-08 11:35:24.099040 n8ZnFFFtORU from=testuser@localhost queued ip=127.0.0.1:59796 to=[to@localhost] +_ queue.go:308 Queue.SendLoop n8ZnFFFtORU: from testuser@localhost +_ queue.go:367 Queue.SendLoop n8ZnFFFtORU: testuser@localhost sent +2025-07-08 11:35:24.099109 n8ZnFFFtORU from=testuser@localhost to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop n8ZnFFFtORU: all done +2025-07-08 11:35:24.099212 n8ZnFFFtORU from=testuser@localhost all done +--- PASS: TestAuth (0.11s) === RUN TestSubmissionWithoutAuth -_ conn.go:318 SMTP.Conn 127.0.0.1:54954: error: MAIL failed: 550 5.7.9 Mail to submission port must be authenticated +_ conn.go:318 SMTP.Conn 127.0.0.1:59808: error: MAIL failed: 550 5.7.9 Mail to submission port must be authenticated --- PASS: TestSubmissionWithoutAuth (0.00s) === RUN TestAuthOnTLS -2025-07-08 11:33:50.329545 127.0.0.1:42218 auth succeeded for testuser@localhost -_ conn.go:722 SMTP.Conn 127.0.0.1:42218: Queued from testuser@localhost to [to@localhost] - cYwWd8Is578 -2025-07-08 11:33:50.330041 cYwWd8Is578 from=testuser@localhost queued ip=127.0.0.1:42218 to=[to@localhost] -_ queue.go:308 Queue.SendLoop cYwWd8Is578: from testuser@localhost -_ queue.go:367 Queue.SendLoop cYwWd8Is578: testuser@localhost sent -2025-07-08 11:33:50.330122 cYwWd8Is578 from=testuser@localhost to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop cYwWd8Is578: all done -2025-07-08 11:33:50.330218 cYwWd8Is578 from=testuser@localhost all done +2025-07-08 11:35:24.210548 127.0.0.1:34692 auth succeeded for testuser@localhost +_ conn.go:722 SMTP.Conn 127.0.0.1:34692: Queued from testuser@localhost to [to@localhost] - rdiMz1O3enk +2025-07-08 11:35:24.211039 rdiMz1O3enk from=testuser@localhost queued ip=127.0.0.1:34692 to=[to@localhost] +_ queue.go:308 Queue.SendLoop rdiMz1O3enk: from testuser@localhost +_ queue.go:367 Queue.SendLoop rdiMz1O3enk: testuser@localhost sent +2025-07-08 11:35:24.211109 rdiMz1O3enk from=testuser@localhost to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop rdiMz1O3enk: all done +2025-07-08 11:35:24.211205 rdiMz1O3enk from=testuser@localhost all done --- PASS: TestAuthOnTLS (0.11s) === RUN TestAuthOnSMTP -2025-07-08 11:33:50.437532 127.0.0.1:47020 auth succeeded for testuser@localhost -_ conn.go:722 SMTP.Conn 127.0.0.1:47020: Queued from testuser@localhost to [to@localhost] - NoNLNryTl_g -2025-07-08 11:33:50.438026 NoNLNryTl_g from=testuser@localhost queued ip=127.0.0.1:47020 to=[to@localhost] -_ queue.go:308 Queue.SendLoop NoNLNryTl_g: from testuser@localhost -_ queue.go:367 Queue.SendLoop NoNLNryTl_g: testuser@localhost sent -2025-07-08 11:33:50.438094 NoNLNryTl_g from=testuser@localhost to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop NoNLNryTl_g: all done -2025-07-08 11:33:50.438183 NoNLNryTl_g from=testuser@localhost all done +2025-07-08 11:35:24.318168 127.0.0.1:43178 auth succeeded for testuser@localhost +_ conn.go:722 SMTP.Conn 127.0.0.1:43178: Queued from testuser@localhost to [to@localhost] - _KanV7Fzuqg +2025-07-08 11:35:24.318712 _KanV7Fzuqg from=testuser@localhost queued ip=127.0.0.1:43178 to=[to@localhost] +_ queue.go:308 Queue.SendLoop _KanV7Fzuqg: from testuser@localhost +_ queue.go:367 Queue.SendLoop _KanV7Fzuqg: testuser@localhost sent +2025-07-08 11:35:24.318797 _KanV7Fzuqg from=testuser@localhost to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop _KanV7Fzuqg: all done +2025-07-08 11:35:24.318897 _KanV7Fzuqg from=testuser@localhost all done --- PASS: TestAuthOnSMTP (0.11s) === RUN TestBrokenAuth -_ conn.go:1193 SMTP.Conn 127.0.0.1:54970: error: error authenticating \"user\"@\"broken\": failed to auth -2025-07-08 11:33:50.545592 127.0.0.1:54970 auth failed for user@broken -_ conn.go:318 SMTP.Conn 127.0.0.1:54970: error: AUTH failed: 454 4.7.0 Temporary authentication failure -_ conn.go:318 SMTP.Conn 127.0.0.1:54970: error: unknown<\"*\"> failed: 500 5.5.1 Unknown command ---- PASS: TestBrokenAuth (0.11s) +_ conn.go:1193 SMTP.Conn 127.0.0.1:59810: error: error authenticating \"user\"@\"broken\": failed to auth +2025-07-08 11:35:24.438629 127.0.0.1:59810 auth failed for user@broken +_ conn.go:318 SMTP.Conn 127.0.0.1:59810: error: AUTH failed: 454 4.7.0 Temporary authentication failure +_ conn.go:318 SMTP.Conn 127.0.0.1:59810: error: unknown<\"*\"> failed: 500 5.5.1 Unknown command +--- PASS: TestBrokenAuth (0.12s) === RUN TestWrongMailParsing -_ conn.go:318 SMTP.Conn 127.0.0.1:47032: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:47032: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:47032: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:47032: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:47048: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:47048: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:47048: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:47048: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:47062: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:47062: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:47062: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:47062: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:47066: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:47066: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:47066: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:47066: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:47072: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:47072: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:47072: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:47072: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:47088: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:47088: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:47088: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:47088: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43184: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43184: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43184: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43184: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43196: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43196: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43196: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43196: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43202: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43202: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43202: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43202: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43210: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43210: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43210: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43210: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43220: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43220: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43220: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43220: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:43236: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:43236: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:43236: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:43236: error: too many errors, breaking connection --- PASS: TestWrongMailParsing (0.00s) === RUN TestNullMailFrom --- PASS: TestNullMailFrom (0.00s) === RUN TestRcptBeforeMail -_ conn.go:318 SMTP.Conn 127.0.0.1:47104: error: RCPT failed: 503 5.5.1 Sender not yet given +_ conn.go:318 SMTP.Conn 127.0.0.1:43264: error: RCPT failed: 503 5.5.1 Sender not yet given --- PASS: TestRcptBeforeMail (0.00s) === RUN TestRcptOption ---- PASS: TestRcptOption (0.03s) +--- PASS: TestRcptOption (0.00s) === RUN TestRelayForbidden -2025-07-08 11:33:50.574200 127.0.0.1:47116 rejected from=from@somewhere to=[to@somewhere] - relay not allowed -_ conn.go:318 SMTP.Conn 127.0.0.1:47116: error: RCPT failed: 503 5.7.1 Relay not allowed +2025-07-08 11:35:24.446387 127.0.0.1:43284 rejected from=from@somewhere to=[to@somewhere] - relay not allowed +_ conn.go:318 SMTP.Conn 127.0.0.1:43284: error: RCPT failed: 503 5.7.1 Relay not allowed --- PASS: TestRelayForbidden (0.00s) === RUN TestTooManyRecipients -2025-07-08 11:33:50.677538 127.0.0.1:54978 auth succeeded for testuser@localhost -_ conn.go:318 SMTP.Conn 127.0.0.1:54978: error: RCPT failed: 452 4.5.3 Too many recipients +2025-07-08 11:35:24.555992 127.0.0.1:59814 auth succeeded for testuser@localhost +_ conn.go:318 SMTP.Conn 127.0.0.1:59814: error: RCPT failed: 452 4.5.3 Too many recipients --- PASS: TestTooManyRecipients (0.11s) === RUN TestRcptBrokenExists -_ conn.go:622 SMTP.Conn 127.0.0.1:47122: error: error checking if user \"to@broken\" exists: failed to check if user exists -2025-07-08 11:33:50.699462 127.0.0.1:47122 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:47122: error: RCPT failed: 451 4.4.3 Temporary error checking address ---- PASS: TestRcptBrokenExists (0.02s) +_ conn.go:622 SMTP.Conn 127.0.0.1:43292: error: error checking if user \"to@broken\" exists: failed to check if user exists +2025-07-08 11:35:24.560958 127.0.0.1:43292 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:43292: error: RCPT failed: 451 4.4.3 Temporary error checking address +--- PASS: TestRcptBrokenExists (0.00s) === RUN TestRcptUserDoesNotExist -2025-07-08 11:33:50.709781 127.0.0.1:47136 rejected from=from@localhost to=[doesnotexist@localhost] - local user does not exist -_ conn.go:318 SMTP.Conn 127.0.0.1:47136: error: RCPT failed: 550 5.1.1 Destination address is unknown (user does not exist) ---- PASS: TestRcptUserDoesNotExist (0.01s) +2025-07-08 11:35:24.563295 127.0.0.1:43298 rejected from=from@localhost to=[doesnotexist@localhost] - local user does not exist +_ conn.go:318 SMTP.Conn 127.0.0.1:43298: error: RCPT failed: 550 5.1.1 Destination address is unknown (user does not exist) +--- PASS: TestRcptUserDoesNotExist (0.00s) === RUN TestTooMuchData -_ conn.go:722 SMTP.Conn 127.0.0.1:47144: Queued from from@from to [to@localhost] - ced1xC6TW44 -2025-07-08 11:33:50.878037 ced1xC6TW44 from=from@from queued ip=127.0.0.1:47144 to=[to@localhost] -_ queue.go:308 Queue.SendLoop ced1xC6TW44: from from@from -_ queue.go:367 Queue.SendLoop ced1xC6TW44: testuser@localhost sent -2025-07-08 11:33:50.878182 ced1xC6TW44 from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop ced1xC6TW44: all done -2025-07-08 11:33:50.911617 ced1xC6TW44 from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:47144: Queued from from@from to [to@localhost] - ZBe2oqa-F2U -2025-07-08 11:33:51.023132 ZBe2oqa-F2U from=from@from queued ip=127.0.0.1:47144 to=[to@localhost] -_ queue.go:308 Queue.SendLoop ZBe2oqa-F2U: from from@from -_ queue.go:367 Queue.SendLoop ZBe2oqa-F2U: testuser@localhost sent -2025-07-08 11:33:51.023278 ZBe2oqa-F2U from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop ZBe2oqa-F2U: all done -2025-07-08 11:33:51.072221 ZBe2oqa-F2U from=from@from all done -_ conn.go:318 SMTP.Conn 127.0.0.1:47144: error: DATA failed: 552 5.3.4 Message too big -_ conn.go:722 SMTP.Conn 127.0.0.1:47144: Queued from from@from to [to@localhost] - Yl_jwrQWzQ4 -2025-07-08 11:33:51.345899 Yl_jwrQWzQ4 from=from@from queued ip=127.0.0.1:47144 to=[to@localhost] -_ queue.go:308 Queue.SendLoop Yl_jwrQWzQ4: from from@from -_ queue.go:367 Queue.SendLoop Yl_jwrQWzQ4: testuser@localhost sent -2025-07-08 11:33:51.346036 Yl_jwrQWzQ4 from=from@from to=testuser@localhost sent ---- PASS: TestTooMuchData (0.64s) +_ conn.go:722 SMTP.Conn 127.0.0.1:43310: Queued from from@from to [to@localhost] - FxDlaQbX5M0 +2025-07-08 11:35:24.665017 FxDlaQbX5M0 from=from@from queued ip=127.0.0.1:43310 to=[to@localhost] +_ queue.go:308 Queue.SendLoop FxDlaQbX5M0: from from@from +_ queue.go:367 Queue.SendLoop FxDlaQbX5M0: testuser@localhost sent +2025-07-08 11:35:24.665173 FxDlaQbX5M0 from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop FxDlaQbX5M0: all done +2025-07-08 11:35:24.678832 FxDlaQbX5M0 from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:43310: Queued from from@from to [to@localhost] - yKY_eURJmYM +2025-07-08 11:35:24.757549 yKY_eURJmYM from=from@from queued ip=127.0.0.1:43310 to=[to@localhost] +_ queue.go:308 Queue.SendLoop yKY_eURJmYM: from from@from +_ queue.go:367 Queue.SendLoop yKY_eURJmYM: testuser@localhost sent +2025-07-08 11:35:24.757690 yKY_eURJmYM from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop yKY_eURJmYM: all done +2025-07-08 11:35:24.772462 yKY_eURJmYM from=from@from all done +_ conn.go:318 SMTP.Conn 127.0.0.1:43310: error: DATA failed: 552 5.3.4 Message too big +_ conn.go:722 SMTP.Conn 127.0.0.1:43310: Queued from from@from to [to@localhost] - LGmaYrJjjSI +2025-07-08 11:35:24.914334 LGmaYrJjjSI from=from@from queued ip=127.0.0.1:43310 to=[to@localhost] +_ queue.go:308 Queue.SendLoop LGmaYrJjjSI: from from@from +_ queue.go:367 Queue.SendLoop LGmaYrJjjSI: testuser@localhost sent +2025-07-08 11:35:24.914494 LGmaYrJjjSI from=from@from to=testuser@localhost sent +--- PASS: TestTooMuchData (0.35s) === RUN TestSimpleCommands -_ conn.go:318 SMTP.Conn 127.0.0.1:47146: 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:47146: error: EXPN failed: 502 5.5.1 You feel disoriented for a moment. ---- PASS: TestSimpleCommands (0.02s) +_ conn.go:318 SMTP.Conn 127.0.0.1:43312: 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:43312: error: EXPN failed: 502 5.5.1 You feel disoriented for a moment. +--- PASS: TestSimpleCommands (0.00s) === RUN TestLongLines -_ queue.go:342 Queue.SendLoop Yl_jwrQWzQ4: all done -2025-07-08 11:33:51.370007 Yl_jwrQWzQ4 from=from@from all done -_ conn.go:318 SMTP.Conn 127.0.0.1:47148: error: unknown<\"\"> failed: 500 5.5.1 Unknown command -_ conn.go:348 SMTP.Conn 127.0.0.1:47148: error: exiting with error: line too long +_ conn.go:318 SMTP.Conn 127.0.0.1:43326: error: unknown<\"\"> failed: 500 5.5.1 Unknown command +_ conn.go:348 SMTP.Conn 127.0.0.1:43326: error: exiting with error: line too long --- PASS: TestLongLines (0.00s) === RUN TestReset --- PASS: TestReset (0.00s) === RUN TestRepeatedStartTLS -_ conn.go:318 SMTP.Conn 127.0.0.1:47172: error: STARTTLS failed: 503 5.5.1 You are already wearing that! ---- PASS: TestRepeatedStartTLS (0.01s) +_ conn.go:318 SMTP.Conn 127.0.0.1:43346: error: STARTTLS failed: 503 5.5.1 You are already wearing that! +--- PASS: TestRepeatedStartTLS (0.00s) === RUN TestStartTLSOnTLS -_ conn.go:318 SMTP.Conn 127.0.0.1:42224: error: STARTTLS failed: 503 5.5.1 You are already wearing that! +_ conn.go:318 SMTP.Conn 127.0.0.1:34704: error: STARTTLS failed: 503 5.5.1 You are already wearing that! --- PASS: TestStartTLSOnTLS (0.00s) === RUN TestAddDKIMSigner - testlib.go:32: test directory: "/tmp/testlib_2052152277" ---- PASS: TestAddDKIMSigner (0.01s) + testlib.go:32: test directory: "/tmp/testlib_193159017" +_ queue.go:342 Queue.SendLoop LGmaYrJjjSI: all done +2025-07-08 11:35:24.926919 LGmaYrJjjSI from=from@from all done +--- PASS: TestAddDKIMSigner (0.00s) === RUN FuzzConnection --- PASS: FuzzConnection (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/smtpsrv 1.605s +ok blitiri.com.ar/go/chasquid/internal/smtpsrv 1.193s === RUN TestParsePolicy sts_test.go:90: pol1: &{Version:STSv1 Mode:enforce MXs:[*.mail.example.com] MaxAge:34h17m36s} --- PASS: TestParsePolicy (0.00s) @@ -2318,19 +2354,19 @@ 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.01s) +--- PASS: TestFetch (0.00s) === RUN TestPolicyTooBig sts_test.go:242: got error as expected: MTA-STS TXT record missing ---- PASS: TestPolicyTooBig (0.14s) +--- PASS: TestPolicyTooBig (0.02s) === RUN TestCacheBasics - testlib.go:32: test directory: "/tmp/testlib_480051701" + testlib.go:32: test directory: "/tmp/testlib_424489754" 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) === RUN TestCacheBadData - testlib.go:32: test directory: "/tmp/testlib_2709328420" + testlib.go:32: test directory: "/tmp/testlib_1193153404" 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} @@ -2339,13 +2375,13 @@ sts_test.go:372: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} --- PASS: TestCacheBadData (0.00s) === RUN TestCacheRefresh - testlib.go:32: test directory: "/tmp/testlib_322470028" + testlib.go:32: test directory: "/tmp/testlib_222613389" 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) === RUN TestCacheSlashSafe - testlib.go:32: test directory: "/tmp/testlib_180077274" + testlib.go:32: test directory: "/tmp/testlib_2518011978" sts_test.go:464: recovered: domain contains slash --- PASS: TestCacheSlashSafe (0.00s) === RUN TestURLForDomain @@ -2353,11 +2389,11 @@ === RUN TestHasSTSRecord --- PASS: TestHasSTSRecord (0.00s) === RUN TestHTTPGet ---- PASS: TestHTTPGet (0.03s) +--- PASS: TestHTTPGet (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/sts 0.225s +ok blitiri.com.ar/go/chasquid/internal/sts 0.088s === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_1088076673" + testlib.go:32: test directory: "/tmp/testlib_1051531514" --- PASS: TestBasic (0.00s) === RUN TestRemoveCheck testlib_test.go:33: recovered: invalid/dangerous directory @@ -2368,54 +2404,54 @@ testlib_test.go:60: recovered: invalid/dangerous path --- PASS: TestRewriteSafeguard (0.00s) === RUN TestRewrite - testlib.go:32: test directory: "/tmp/testlib_1191341994" + testlib.go:32: test directory: "/tmp/testlib_3768570443" --- 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_3090460151" ---- PASS: TestGenerateCert (0.05s) + testlib.go:32: test directory: "/tmp/testlib_203664607" +--- PASS: TestGenerateCert (0.04s) === RUN TestGenerateCertBadDir ---- PASS: TestGenerateCertBadDir (0.05s) +--- PASS: TestGenerateCertBadDir (0.02s) PASS -ok blitiri.com.ar/go/chasquid/internal/testlib 0.164s +ok blitiri.com.ar/go/chasquid/internal/testlib 0.120s === RUN TestVersionName --- PASS: TestVersionName (0.00s) === RUN TestCipherSuiteName --- PASS: TestCipherSuiteName (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/tlsconst 0.032s +ok blitiri.com.ar/go/chasquid/internal/tlsconst 0.024s === RUN TestEmptyLoad - userdb_test.go:37: file: "/tmp/userdb_test4055850833" - userdb_test.go:37: file: "/tmp/userdb_test664923187" + userdb_test.go:37: file: "/tmp/userdb_test3546372893" + userdb_test.go:37: file: "/tmp/userdb_test4254667456" --- PASS: TestEmptyLoad (0.00s) === RUN TestWrite - userdb_test.go:37: file: "/tmp/userdb_test3107404834" ---- PASS: TestWrite (0.50s) + userdb_test.go:37: file: "/tmp/userdb_test3966637470" +--- PASS: TestWrite (0.38s) === RUN TestNew --- PASS: TestNew (0.05s) === RUN TestInvalidUsername - userdb_test.go:37: file: "/tmp/userdb_test2993776398" + userdb_test.go:37: file: "/tmp/userdb_test2788175859" --- PASS: TestInvalidUsername (0.00s) === RUN TestPlainScheme - userdb_test.go:37: file: "/tmp/userdb_test2004023318" + userdb_test.go:37: file: "/tmp/userdb_test2270540227" --- PASS: TestPlainScheme (0.00s) === RUN TestDeniedScheme - userdb_test.go:37: file: "/tmp/userdb_test1957038232" + userdb_test.go:37: file: "/tmp/userdb_test2632305079" --- PASS: TestDeniedScheme (0.00s) === RUN TestReload - userdb_test.go:37: file: "/tmp/userdb_test3832686866" + userdb_test.go:37: file: "/tmp/userdb_test1084446339" --- PASS: TestReload (0.00s) === RUN TestRemoveUser - userdb_test.go:37: file: "/tmp/userdb_test372227107" ---- PASS: TestRemoveUser (0.07s) + userdb_test.go:37: file: "/tmp/userdb_test3755286678" +--- PASS: TestRemoveUser (0.05s) === RUN TestExists - userdb_test.go:37: file: "/tmp/userdb_test602031431" + userdb_test.go:37: file: "/tmp/userdb_test2483664671" --- PASS: TestExists (0.06s) PASS -ok blitiri.com.ar/go/chasquid/internal/userdb 0.705s +ok blitiri.com.ar/go/chasquid/internal/userdb 0.573s create-stamp debian/debhelper-build-stamp dh_testroot -O--buildsystem=golang dh_prep -O--buildsystem=golang @@ -2478,12 +2514,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/3279766/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/3279766/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/3535493 and its subdirectories -I: Current time: Mon Jul 7 23:34:10 -12 2025 -I: pbuilder-time-stamp: 1751974450 +I: removing directory /srv/workspace/pbuilder/3279766 and its subdirectories +I: Current time: Wed Jul 9 01:35:47 +14 2025 +I: pbuilder-time-stamp: 1751974547