Diff of the two buildlogs: -- --- b1/build.log 2025-01-02 00:02:31.011934291 +0000 +++ b2/build.log 2025-01-02 00:04:57.329250460 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed Jan 1 12:01:12 -12 2025 -I: pbuilder-time-stamp: 1735776072 +I: Current time: Wed Feb 4 20:25:37 +14 2026 +I: pbuilder-time-stamp: 1770186337 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/unstable-reproducible-base.tgz] I: copying local configuration @@ -24,52 +24,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/1716266/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/567331/tmp/hooks/D01_modify_environment starting +debug: Running on codethink03-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 Feb 4 06:25 /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/567331/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/567331/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]="37" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.2.37(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=arm64 + DEBIAN_FRONTEND=noninteractive DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=12 ' - DISTRIBUTION='unstable' - HOME='/root' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION=unstable + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - INVOCATION_ID='396bcd18a9734796b1882291f5075de9' - 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='1716266' - PS1='# ' - PS2='> ' + INVOCATION_ID=29e48d7ab1504b6ba92304e23db92a71 + 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=567331 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.Ap81aPle/pbuilderrc_esDR --distribution unstable --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.Ap81aPle/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.Ap81aPle/pbuilderrc_37fC --distribution unstable --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.Ap81aPle/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 codethink02-arm64 6.1.0-28-cloud-arm64 #1 SMP Debian 6.1.119-1 (2024-11-22) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-28-cloud-arm64 #1 SMP Debian 6.1.119-1 (2024-11-22) aarch64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Nov 22 14:40 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/1716266/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Nov 22 2024 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/567331/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -173,7 +205,7 @@ Get: 44 http://deb.debian.org/debian unstable/main arm64 golang-blitiri-go-log-dev all 1.1.0-1 [6724 B] Get: 45 http://deb.debian.org/debian unstable/main arm64 golang-blitiri-go-spf-dev all 1.5.1-1 [37.2 kB] Get: 46 http://deb.debian.org/debian unstable/main arm64 golang-blitiri-go-systemd-dev all 1.1.0-1 [6952 B] -Fetched 70.3 MB in 0s (222 MB/s) +Fetched 70.3 MB in 1s (132 MB/s) Preconfiguring packages ... 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 ... 19975 files and directories currently installed.) @@ -372,7 +404,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/567331/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for unstable +I: user script /srv/workspace/pbuilder/567331/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 @@ -394,251 +430,251 @@ 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 encoding -internal/godebugs +cmp internal/goarch -internal/itoa -internal/abi -internal/byteorder +internal/unsafeheader internal/coverage/rtcov +internal/godebugs +internal/byteorder +internal/itoa internal/goos -internal/profilerecord internal/goexperiment -internal/cpu runtime/internal/math internal/race -cmp -internal/runtime/syscall -internal/unsafeheader math/bits +internal/profilerecord unicode/utf8 -sync/atomic -runtime/internal/sys +internal/cpu +internal/runtime/syscall unicode +internal/chacha8rand +runtime/internal/sys +sync/atomic +internal/abi +math internal/asan internal/msan log/internal -internal/chacha8rand -math internal/nettrace google.golang.org/protobuf/internal/flags unicode/utf16 google.golang.org/protobuf/internal/set -internal/bytealg -internal/runtime/atomic container/ring container/list crypto/internal/alias crypto/subtle crypto/internal/boring/sig vendor/golang.org/x/crypto/cryptobyte/asn1 +internal/runtime/atomic +internal/bytealg vendor/golang.org/x/crypto/internal/alias blitiri.com.ar/go/chasquid/internal/set internal/runtime/exithook internal/stringslite runtime -internal/reflectlite iter -internal/weak sync -maps +internal/weak +internal/reflectlite slices +maps internal/bisect -internal/singleflight internal/testlog +internal/singleflight google.golang.org/protobuf/internal/pragma runtime/cgo -internal/godebug errors sort +internal/godebug +strconv internal/oserror -vendor/golang.org/x/net/dns/dnsmessage path -strconv -io -syscall +vendor/golang.org/x/net/dns/dnsmessage math/rand/v2 crypto/internal/edwards25519/field -math/rand crypto/internal/nistec/fiat -golang.org/x/text/internal/tag +io +math/rand +syscall strings +internal/concurrent +reflect +crypto/internal/randutil hash +golang.org/x/text/internal/tag +crypto/internal/edwards25519 bytes -crypto/internal/randutil hash/fnv -internal/concurrent +crypto/rc4 hash/crc32 -crypto/internal/edwards25519 +html +regexp/syntax unique crypto -crypto/rc4 -reflect +net/http/internal/ascii +crypto/md5 +bufio crypto/cipher vendor/golang.org/x/text/transform golang.org/x/text/transform -crypto/md5 -bufio net/netip -html -regexp/syntax -net/http/internal/ascii -crypto/internal/boring -crypto/des golang.org/x/text/runes golang.org/x/text/width +crypto/internal/boring +crypto/des crypto/aes crypto/sha512 crypto/hmac crypto/sha1 -vendor/golang.org/x/crypto/hkdf crypto/sha256 +vendor/golang.org/x/crypto/hkdf golang.org/x/crypto/pbkdf2 time -internal/syscall/execenv internal/syscall/unix +internal/syscall/execenv regexp -io/fs -context internal/poll +context +io/fs internal/filepathlite embed google.golang.org/protobuf/internal/editiondefaults crypto/internal/nistec +os internal/fmtsort encoding/binary -os encoding/base64 vendor/golang.org/x/crypto/chacha20 +vendor/golang.org/x/crypto/internal/poly1305 golang.org/x/crypto/scrypt golang.org/x/sys/unix -vendor/golang.org/x/crypto/internal/poly1305 -encoding/pem crypto/ecdh +encoding/pem vendor/golang.org/x/crypto/chacha20poly1305 -google.golang.org/protobuf/internal/detrand -blitiri.com.ar/go/chasquid/internal/safeio -os/signal fmt path/filepath +google.golang.org/protobuf/internal/detrand io/ioutil +blitiri.com.ar/go/chasquid/internal/safeio +vendor/golang.org/x/sys/cpu +os/signal internal/sysinfo net -vendor/golang.org/x/sys/cpu -vendor/golang.org/x/crypto/sha3 os/exec +vendor/golang.org/x/crypto/sha3 flag log google.golang.org/protobuf/internal/errors -go/token +text/template/parse compress/flate encoding/json google.golang.org/protobuf/internal/version net/url -text/template/parse +go/token math/big -google.golang.org/protobuf/encoding/protowire encoding/hex -google.golang.org/protobuf/reflect/protoreflect -vendor/golang.org/x/text/unicode/bidi +google.golang.org/protobuf/encoding/protowire vendor/golang.org/x/text/unicode/norm vendor/golang.org/x/net/http2/hpack +google.golang.org/protobuf/reflect/protoreflect +vendor/golang.org/x/text/unicode/bidi mime mime/quotedprintable compress/gzip net/http/internal blitiri.com.ar/go/chasquid/internal/envelope -vendor/golang.org/x/text/secure/bidirule golang.org/x/text/unicode/bidi golang.org/x/text/unicode/norm +text/template golang.org/x/text/internal/language +vendor/golang.org/x/text/secure/bidirule blitiri.com.ar/go/chasquid/internal/tlsconst -internal/profile -text/tabwriter -text/template google.golang.org/protobuf/internal/encoding/messageset google.golang.org/protobuf/internal/strs google.golang.org/protobuf/internal/genid -google.golang.org/protobuf/internal/encoding/text google.golang.org/protobuf/internal/order +google.golang.org/protobuf/internal/encoding/text google.golang.org/protobuf/reflect/protoregistry google.golang.org/protobuf/runtime/protoiface google.golang.org/protobuf/internal/descfmt google.golang.org/protobuf/internal/descopts -vendor/golang.org/x/net/idna golang.org/x/text/secure/bidirule -runtime/pprof +internal/profile +google.golang.org/protobuf/proto +text/tabwriter +google.golang.org/protobuf/internal/encoding/defval runtime/trace runtime/debug +vendor/golang.org/x/net/idna +runtime/pprof +golang.org/x/term golang.org/x/text/internal/language/compact +golang.org/x/text/language +testing +google.golang.org/protobuf/encoding/prototext +google.golang.org/protobuf/internal/filedesc +html/template +golang.org/x/net/idna crypto/rand -google.golang.org/protobuf/proto crypto/elliptic crypto/internal/bigmod -google.golang.org/protobuf/internal/encoding/defval crypto/internal/boring/bbig encoding/asn1 crypto/ed25519 crypto/internal/hpke crypto/internal/mlkem768 -crypto/dsa -golang.org/x/net/idna -golang.org/x/text/language -golang.org/x/term -testing -html/template crypto/rsa -google.golang.org/protobuf/encoding/prototext -google.golang.org/protobuf/internal/filedesc -vendor/golang.org/x/crypto/cryptobyte -crypto/x509/pkix +crypto/dsa golang.org/x/text/internal golang.org/x/text/cases -crypto/ecdsa blitiri.com.ar/go/chasquid/internal/protoio +vendor/golang.org/x/crypto/cryptobyte +crypto/x509/pkix +crypto/ecdsa golang.org/x/text/secure/precis google.golang.org/protobuf/internal/encoding/tag google.golang.org/protobuf/internal/impl blitiri.com.ar/go/chasquid/internal/normalize +google.golang.org/protobuf/internal/filetype log/syslog +crypto/x509 +net/textproto vendor/golang.org/x/net/http/httpproxy blitiri.com.ar/go/chasquid/internal/haproxy -net/textproto -crypto/x509 blitiri.com.ar/go/spf blitiri.com.ar/go/systemd blitiri.com.ar/go/log +google.golang.org/protobuf/runtime/protoimpl vendor/golang.org/x/net/http/httpguts mime/multipart blitiri.com.ar/go/chasquid/internal/dovecot net/mail +blitiri.com.ar/go/chasquid/internal/config blitiri.com.ar/go/chasquid/cmd/mda-lmtp -google.golang.org/protobuf/internal/filetype +blitiri.com.ar/go/chasquid/internal/userdb +blitiri.com.ar/go/chasquid/internal/protoio/testpb blitiri.com.ar/go/chasquid/internal/dkim crypto/tls -google.golang.org/protobuf/runtime/protoimpl -blitiri.com.ar/go/chasquid/internal/protoio/testpb -blitiri.com.ar/go/chasquid/internal/userdb -blitiri.com.ar/go/chasquid/internal/config net/http/httptrace net/smtp blitiri.com.ar/go/chasquid/internal/testlib net/http blitiri.com.ar/go/chasquid/internal/smtp -expvar blitiri.com.ar/go/chasquid/internal/nettrace +expvar golang.org/x/net/context/ctxhttp net/http/pprof blitiri.com.ar/go/chasquid/internal/expvarom blitiri.com.ar/go/chasquid/internal/trace blitiri.com.ar/go/chasquid/internal/domaininfo -blitiri.com.ar/go/chasquid/internal/sts blitiri.com.ar/go/chasquid/internal/localrpc blitiri.com.ar/go/chasquid/internal/maillog -blitiri.com.ar/go/chasquid/internal/aliases blitiri.com.ar/go/chasquid/internal/auth +blitiri.com.ar/go/chasquid/internal/sts +blitiri.com.ar/go/chasquid/internal/aliases blitiri.com.ar/go/chasquid/cmd/chasquid-util -blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/courier +blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/queue blitiri.com.ar/go/chasquid/internal/smtpsrv blitiri.com.ar/go/chasquid @@ -678,7 +714,7 @@ _ aliases.go:547 Hook.Alias-Resolve a@localA: error: exit status 1 _ aliases.go:547 Hook.Alias-Resolve *@localA: error: exit status 1 _ aliases.go:547 Hook.Alias-Resolve a@localA: error: exit status 1 ---- PASS: TestHookError (0.01s) +--- PASS: TestHookError (0.07s) === RUN FuzzReader === RUN FuzzReader/seed#0 === RUN FuzzReader/1c24d2215db69748c6fd16797673ad11ebc7e6167fe1bc1f54c6959ec10407b6 @@ -694,7 +730,7 @@ --- PASS: FuzzReader/c9c80ba9f513841cb081fe9bb7439d36f9f7a06bb999d4c39441991ccc878a9e (0.00s) --- PASS: FuzzReader/d40a98862ed393eb712e47a91bcef18e6f24cf368bb4bd248c7a7101ef8e178d (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/aliases 0.032s +ok blitiri.com.ar/go/chasquid/internal/aliases 0.124s === 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 @@ -707,11 +743,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.37s) +--- PASS: TestAuthenticate (0.48s) === RUN TestInterfaces --- PASS: TestInterfaces (0.00s) === RUN TestMultipleBackends ---- PASS: TestMultipleBackends (0.19s) +--- PASS: TestMultipleBackends (0.20s) === RUN TestErrors --- PASS: TestErrors (0.00s) === RUN TestReload @@ -740,46 +776,46 @@ --- PASS: FuzzDecodeResponse/d9aa9c617d1f5b3021aca758b9d896d136e3b16ed53233d02abffd02aa73ffa4 (0.00s) --- PASS: FuzzDecodeResponse/de05c7993312bab83e8114e9d9ced331c49822dc55c1a353f1cc9718a28226e7 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/auth 0.578s +ok blitiri.com.ar/go/chasquid/internal/auth 0.726s === RUN TestEmptyStruct --- PASS: TestEmptyStruct (0.00s) === RUN TestEmptyConfig - testlib.go:32: test directory: "/tmp/testlib_1357116637" + testlib.go:32: test directory: "/tmp/testlib_3045940784" --- PASS: TestEmptyConfig (0.00s) === RUN TestFullConfig - testlib.go:32: test directory: "/tmp/testlib_1023082597" + testlib.go:32: test directory: "/tmp/testlib_2757499515" --- PASS: TestFullConfig (0.00s) === RUN TestErrorLoading --- PASS: TestErrorLoading (0.00s) === RUN TestBrokenConfig - testlib.go:32: test directory: "/tmp/testlib_2590465902" + testlib.go:32: test directory: "/tmp/testlib_3235873515" --- PASS: TestBrokenConfig (0.00s) === RUN TestBrokenOverride - testlib.go:32: test directory: "/tmp/testlib_2951897255" + testlib.go:32: test directory: "/tmp/testlib_1788215806" --- PASS: TestBrokenOverride (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/config 0.023s +ok blitiri.com.ar/go/chasquid/internal/config 0.056s ? blitiri.com.ar/go/chasquid/internal/protoio/testpb [no test files] === RUN TestMDA - testlib.go:32: test directory: "/tmp/testlib_4140848601" ---- PASS: TestMDA (0.00s) + testlib.go:32: test directory: "/tmp/testlib_1754362598" +--- PASS: TestMDA (0.03s) === RUN TestMDATimeout _ mda.go:73 Courier.MDA to@local: error: operation timed out ---- PASS: TestMDATimeout (0.10s) +--- PASS: TestMDATimeout (0.11s) === RUN TestMDABadCommandLine _ mda.go:86 Courier.MDA to: error: MDA delivery failed: exec: \"thisdoesnotexist\": executable file not found in $PATH - \"\" _ mda.go:86 Courier.MDA to: error: MDA delivery failed: exit status 1 - \"cat: unrecognized option '--fail_unknown_option'\\nTry 'cat --help' for more information.\\n\" ---- PASS: TestMDABadCommandLine (0.00s) +--- PASS: TestMDABadCommandLine (0.02s) === RUN TestExitCode mda_test.go:71: util/exitcode not found, running from outside repo? --- SKIP: TestExitCode (0.00s) === RUN TestSanitize --- PASS: TestSanitize (0.00s) === RUN TestSMTP - testlib.go:32: test directory: "/tmp/testlib_999341431" - testlib.go:32: test directory: "/tmp/testlib_624015709" -_ smtp.go:127 Courier.SMTP to@to: error: Could not dial: dial tcp: address ::::37035: too many colons in address -_ smtp.go:101 Courier.SMTP to@to: error: \":::\" returned transient error: Could not dial: dial tcp: address ::::37035: too many colons in address + testlib.go:32: test directory: "/tmp/testlib_3147006018" + testlib.go:32: test directory: "/tmp/testlib_143237712" +_ smtp.go:127 Courier.SMTP to@to: error: Could not dial: dial tcp: address ::::42829: too many colons in address +_ smtp.go:101 Courier.SMTP to@to: error: \":::\" returned transient error: Could not dial: dial tcp: address ::::42829: 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:" @@ -787,26 +823,26 @@ fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestSMTP (0.03s) +--- PASS: TestSMTP (0.08s) === RUN TestSMTPErrors - testlib.go:32: test directory: "/tmp/testlib_1358168312" - testlib.go:32: test directory: "/tmp/testlib_896363857" + testlib.go:32: test directory: "/tmp/testlib_915527599" + testlib.go:32: test directory: "/tmp/testlib_466606088" fakeserver_test.go:98: fakeServer got connection -_ smtp.go:138 Courier.SMTP to@to: error: Error saying hello: write tcp 127.0.0.1:50072->127.0.0.1:39657: 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:50072->127.0.0.1:39657: 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:50072->127.0.0.1:39657: 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:50072->127.0.0.1:39657: i/o timeout) +_ smtp.go:138 Courier.SMTP to@to: error: Error saying hello: write tcp 127.0.0.1:45140->127.0.0.1:43539: 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:45140->127.0.0.1:43539: 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:45140->127.0.0.1:43539: 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:45140->127.0.0.1:43539: i/o timeout) fakeserver_test.go:105: fakeServer exiting: EOF - testlib.go:32: test directory: "/tmp/testlib_74063723" - testlib.go:32: test directory: "/tmp/testlib_603904368" + testlib.go:32: test directory: "/tmp/testlib_3031935866" + testlib.go:32: test directory: "/tmp/testlib_3675176044" 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_2493806634" - testlib.go:32: test directory: "/tmp/testlib_306520758" + testlib.go:32: test directory: "/tmp/testlib_2206298786" + testlib.go:32: test directory: "/tmp/testlib_3811538786" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -814,8 +850,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_3422552932" - testlib.go:32: test directory: "/tmp/testlib_3328990755" + testlib.go:32: test directory: "/tmp/testlib_2643283500" + testlib.go:32: test directory: "/tmp/testlib_3325925180" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -824,8 +860,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_2942740045" - testlib.go:32: test directory: "/tmp/testlib_3611627178" + testlib.go:32: test directory: "/tmp/testlib_128250399" + testlib.go:32: test directory: "/tmp/testlib_2791836243" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -834,9 +870,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.30s) +--- PASS: TestSMTPErrors (1.70s) === RUN TestNoMXServer - testlib.go:32: test directory: "/tmp/testlib_2112171439" + testlib.go:32: test directory: "/tmp/testlib_795247427" _ 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) @@ -851,8 +887,8 @@ === RUN TestLookupInvalidDomain --- PASS: TestLookupInvalidDomain (0.00s) === RUN TestTLS - testlib.go:32: test directory: "/tmp/testlib_3068927623" - testlib.go:32: test directory: "/tmp/testlib_2815245038" + testlib.go:32: test directory: "/tmp/testlib_1019769423" + testlib.go:32: test directory: "/tmp/testlib_909501999" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -863,7 +899,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_1945121329" + testlib.go:32: test directory: "/tmp/testlib_611711071" 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 @@ -871,10 +907,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.08s) +--- PASS: TestTLS (0.23s) === RUN TestTLSError - testlib.go:32: test directory: "/tmp/testlib_1070430210" - testlib.go:32: test directory: "/tmp/testlib_4272015860" + testlib.go:32: test directory: "/tmp/testlib_2000761261" + testlib.go:32: test directory: "/tmp/testlib_2508896718" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -887,10 +923,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.05s) +--- PASS: TestTLSError (0.06s) === RUN TestSTSPolicyEnforcement - testlib.go:32: test directory: "/tmp/testlib_1404956136" - testlib.go:32: test directory: "/tmp/testlib_2184688613" + testlib.go:32: test directory: "/tmp/testlib_86853807" + testlib.go:32: test directory: "/tmp/testlib_3148218218" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -898,7 +934,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_4147194435" + testlib.go:32: test directory: "/tmp/testlib_3252486425" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -909,9 +945,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.14s) PASS -ok blitiri.com.ar/go/chasquid/internal/courier 1.688s +ok blitiri.com.ar/go/chasquid/internal/courier 2.401s === RUN TestStringToCanonicalization --- PASS: TestStringToCanonicalization (0.00s) === RUN TestSimpleBody @@ -919,7 +955,7 @@ === RUN TestRelaxBody --- PASS: TestRelaxBody (0.00s) === RUN TestHeaders ---- PASS: TestHeaders (0.00s) +--- PASS: TestHeaders (0.01s) === RUN TestBadCanonicalization --- PASS: TestBadCanonicalization (0.00s) === RUN TestTraceNoCtx @@ -947,7 +983,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:[0x4000227e60 0x4000227ec0]} + file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0x4000225e60 0x4000225ec0]} 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; @@ -1151,7 +1187,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:[0x4000251f20 0x40002ba000]} + file_test.go:56: Want result: &{Found:2 Valid:1 Results:[0x4000251f20 0x40002b6000]} 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; @@ -1185,7 +1221,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:[0x40002ba660 0x40002ba6c0]} + file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0x40002b6660 0x40002b66c0]} 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; @@ -1232,7 +1268,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:[0x40002bade0 0x40002bae40 0x40002baea0]} + file_test.go:56: Want result: &{Found:3 Valid:3 Results:[0x40002b6de0 0x40002b6e40 0x40002b6ea0]} 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; @@ -1292,7 +1328,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:[0x40002bb680 0x40002bb6e0 0x40002bb740]} + file_test.go:56: Want result: &{Found:3 Valid:3 Results:[0x40002b7680 0x40002b76e0 0x40002b7740]} 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; @@ -1352,7 +1388,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:[0x400032c000 0x400032c060]} + file_test.go:56: Want result: &{Found:2 Valid:2 Results:[0x4000326000 0x4000326060]} 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; @@ -1398,7 +1434,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:[0x400032c720]} + file_test.go:56: Want result: &{Found:1 Valid:0 Results:[0x4000326720]} 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; @@ -1419,14 +1455,14 @@ context.go:17: Resulting hash: "kFTkVTyR9JWKX/Stl1+sUIuAgitRiOf7MwTBy5a2/ZA=" context.go:17: PK [ed25519:4afa0f4faf766d5a]: Strict domain check failed: "example.com" != "sub.example.com" ("test@sub.example.com") context.go:17: Found 1 signatures, 0 valid ---- PASS: TestFromFiles (0.01s) +--- PASS: TestFromFiles (0.02s) --- PASS: TestFromFiles/testdata/01-rfc8463 (0.00s) - --- PASS: TestFromFiles/testdata/02-too_many_headers (0.00s) + --- PASS: TestFromFiles/testdata/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) --- PASS: TestFromFiles/testdata/06-dns_perm_error (0.00s) - --- PASS: TestFromFiles/testdata/07-algo_mismatch (0.00s) + --- PASS: TestFromFiles/testdata/07-algo_mismatch (0.01s) --- PASS: TestFromFiles/testdata/08-our_signature (0.00s) --- PASS: TestFromFiles/testdata/09-limited_body (0.00s) --- PASS: TestFromFiles/testdata/10-strict_domain_check_pass (0.00s) @@ -1454,18 +1490,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=1735776126; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "o8x9d7g4dgma7IH921l1n6eObLzfvZyFfSj42SOTNbg=" + context.go:17: Hashing header: "dkim-signature:v=1; a=rsa-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1770186440; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "kQtJB9AkYGrpJD5qSKk5nF4/u4osyQpV29OPOUW7Ots=" context.go:17: Found DKIM-Signature header: v=1; a=rsa-sha256; c=relaxed/relaxed; - d=example.com; s=test; t=1735776126; + d=example.com; s=test; t=1770186440; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; - b=gBCt5PKl9pG2YI/jdpHNkcNCnyepqLQ3MDUMZuvd4hOkl12onuEDdoYezGI/bNj2CSJORG - AOcqINa1Yyuabfeyp98JBHh0WEzOjXMRVusdqsXVXgUQSVC/wSKr5xhItsR7tE48qGY6rT - 4HwjZQ//TaMKuMUdGbTcBxJvHexQ2tg3jPdnxcvOwXlralqpwxzq2hoPYWr0/l5h1bQdbB - VNS1yNYCvFviuvQeO81aSX3qa9YZCEVRSqW4zPb24Qt1EA08D7UWNL4ChaeBFxgKMyz17f - LouwH59tD+SExdpi+VvWGVRj5fz1m+Z7bHsomOja2sVHWGWBYhg4fnCNdB6qDQ==; - context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; p=MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAvab4uqY9XByH7vMem01Cju6uiKHgs4TTh+yUXu69eBKBQ/mS8CmSQaqitU2YJtq9/GZeReze7ZDWFmjsyhStYEQmQ0B94vbv1kkBkngNMSJteuY2kxIaUXPomas/1ZZIa5kSKqDZComUi7rOneFrP2qn8hIDRehfqolpq3OCv8JJt8lWQHzhKrrP8aZuGCuRkn1k74xp7qYlPnBuXPKqXj9jiPP71LNOyUlZ5UYXsET+CzpzXlnjroVUhSrbR5mC9szuzUasuhj+hAN7QM1mfng5CCuYUVGVYlJmE1LfaJMaNGpPJh6ZcxXPYKiFVU54LBrv/9JVDgL+DM6O60TDoQIDAQAB" + b=HwwtUBgvBdrPe3NBkXLtdehE2vTICdcZQa54fgx/ROb1sftQpTEwxeItNLt21D7xNqjufS + c37rejoD0t5nt8+1BOuzIOHa8dIn6mOETe31pS32k5Eg0GUBI9kfwftRZ4/da/GzF7s6hX + 9z9P4q1oAUFgSddZSN/+3NggYGV4olQXG5WODkJmwAKO73LI4T5WLsHFn0gDtfz9Drmxg7 + SqQ9houGmSEGwQSuEt/vdE2wGD6kgV6InX3zS5oFAAZjgKco1VKaLiVNhuyVWPdrNCBmok + 5572349LgjYHwv0d0cOSo3O7n8tNgD8Wn1dO2vagpZlCXlyKrC9PURH7q3RAwg==; + context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; p=MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAmLR0mi1jR7pTix3DiT/H1UhblyjPJFIbuqooDlr5j48M3Gd79de9mfsq25Wd5790XPlcnUL27KoFi4AumFa0lxPUumLEIA+cKeVCT5jvd2rmcxA/258zPWPqC6Wx8aJac0NDrXvpbgv98kWIREoB06qL8Dh0dtRY4JNEPEinyo2Aaqtq4yTqLywjGiPp5S8QAxp7SuMYfiF3hRpv4MsUkI9vKKDn/Q5SYn3V2eM1/C5lQD7kCTtbfF4u6HXebEvSsgEuZlklOsrxp+ikVr+EQH/C7A0sujf5M8+mMAWlDObZq9v66uaoci97vts4IMF2lUBBLOzj9GDosSut6IqIzQIDAQAB" 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" @@ -1473,11 +1509,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=1735776126; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "o8x9d7g4dgma7IH921l1n6eObLzfvZyFfSj42SOTNbg=" + context.go:17: Hashing header: "dkim-signature:v=1; a=rsa-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1770186440; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "kQtJB9AkYGrpJD5qSKk5nF4/u4osyQpV29OPOUW7Ots=" context.go:17: PK [rsa:30820122300d0609]: Verification succeeded context.go:17: Found 1 signatures, 1 valid ---- PASS: TestSignRSA (0.65s) +--- PASS: TestSignRSA (0.56s) === RUN TestSignEd25519 context.go:17: Signing for example.com / test with ed25519-sha256 context.go:17: Hashing header: "from:Joe SixPack \r\n" @@ -1485,25 +1521,25 @@ 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=1735776126; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "RuJJ6ce3LJCcMxy5otVqEFv3EZE/WFDfVIrHbRR0WjU=" + context.go:17: Hashing header: "dkim-signature:v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1770186440; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "fsF478IbkhlxeVleArh1PSa5S4XG9t9Wy0i1/4sblUE=" context.go:17: Found DKIM-Signature header: v=1; a=ed25519-sha256; c=relaxed/relaxed; - d=example.com; s=test; t=1735776126; + d=example.com; s=test; t=1770186440; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; - b=e6BwTDtUrw/XBUAFn9NbyxzgZuhav4fKPn4asGb5jO7ynHb9w/ZW1nT18fNn8HaZklAv1W - p9JHz4ODNQfuWZAw==; - context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; k=ed25519; p=UeKH1a91+hIKkXfCPOqt1BuopJAMdy3eqYyicoUvky0=" - context.go:17: Parsed public key: [ed25519:51e287d5af75fa12] + b=KGBe7JalbQYpWHvKQ9vzmEw53bbEHSRQnQi3L60iRsYkgcPdNJfnUv3x3Zl8AzrzsaEmLk + t37mwZRUwB5NZ0Bg==; + context.go:17: TXT record for "test._domainkey.example.com": "v=DKIM1; k=ed25519; p=zlsIAlVFc9veubbjJ3/0vBH1sCJ2sZCTnh9brl8E/14=" + context.go:17: Parsed public key: [ed25519:ce5b0802554573db] 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=1735776126; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" - context.go:17: Resulting hash: "RuJJ6ce3LJCcMxy5otVqEFv3EZE/WFDfVIrHbRR0WjU=" - context.go:17: PK [ed25519:51e287d5af75fa12]: Verification succeeded + context.go:17: Hashing header: "dkim-signature:v=1; a=ed25519-sha256; c=relaxed/relaxed; d=example.com; s=test; t=1770186440; h=from:subject:date:to:message-id:from:subject:date:to:cc:message-id; bh=2jUSOH9NhtVGCQWNr9BrIAPreKQjO6Sn7XIkfJVOzv8=; b=;" + context.go:17: Resulting hash: "fsF478IbkhlxeVleArh1PSa5S4XG9t9Wy0i1/4sblUE=" + context.go:17: PK [ed25519:ce5b0802554573db]: Verification succeeded context.go:17: Found 1 signatures, 1 valid --- PASS: TestSignEd25519 (0.01s) === RUN TestSignBadMessage @@ -1666,7 +1702,7 @@ context.go:17: Resulting hash: "f2IsMaznsSl75RyN3HCeXBCknzhGOAtiH+WoXk/PiLI=" context.go:17: PK [rsa:30819f300d06092a]: Verification failed: crypto/rsa: verification error context.go:17: Found 2 signatures, 0 valid ---- PASS: TestVerifyRFC8463Example (0.00s) +--- PASS: TestVerifyRFC8463Example (0.01s) === RUN TestHeadersToInclude --- PASS: TestHeadersToInclude (0.00s) === RUN TestAuthenticationResults @@ -1702,9 +1738,9 @@ --- PASS: FuzzParsePublicKey/seed#12 (0.00s) --- PASS: FuzzParsePublicKey/seed#13 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/dkim 0.703s +ok blitiri.com.ar/go/chasquid/internal/dkim 0.664s === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_2685057329" + testlib.go:32: test directory: "/tmp/testlib_3505741643" _ 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 @@ -1713,14 +1749,14 @@ _ domaininfo.go:182 DomainInfo.SetToPlain d1: set to plain --- PASS: TestBasic (0.00s) === RUN TestNewDomain - testlib.go:32: test directory: "/tmp/testlib_796083023" + testlib.go:32: test directory: "/tmp/testlib_2402651001" _ domaininfo.go:153 DomainInfo.Outgoing insecure: insecure outgoing level raised: TLS_INSECURE > PLAIN _ domaininfo.go:117 DomainInfo.Incoming insecure: insecure incoming level raised: TLS_INSECURE > PLAIN _ domaininfo.go:153 DomainInfo.Outgoing secure: secure outgoing level raised: TLS_SECURE > PLAIN _ domaininfo.go:117 DomainInfo.Incoming secure: secure incoming level raised: TLS_SECURE > PLAIN ---- PASS: TestNewDomain (0.00s) +--- PASS: TestNewDomain (0.01s) === RUN TestProgressions - testlib.go:32: test directory: "/tmp/testlib_1730993540" + testlib.go:32: test directory: "/tmp/testlib_3079940737" _ 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 @@ -1735,27 +1771,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_3025328785" + testlib.go:32: test directory: "/tmp/testlib_753033110" _ domaininfo.go:117 DomainInfo.Incoming d1: d1 incoming level raised: TLS_SECURE > PLAIN _ domaininfo.go:67 DomainInfo.Reload reload: error: id \"d1\": proto: syntax error (line 1:1): invalid field name: invalid-text-protobuf-contents _ domaininfo.go:67 DomainInfo.Reload reload: error: id \"d1\": proto: syntax error (line 1:1): invalid field name: invalid-text-protobuf-contents --- PASS: TestErrors (0.00s) === RUN TestDirectoryErrors - testlib.go:32: test directory: "/tmp/testlib_537532464" -_ domaininfo.go:59 DomainInfo.Reload reload: error: open /tmp/testlib_537532464/db: no such file or directory -_ domaininfo.go:84 DomainInfo.write d1: error: open /tmp/testlib_537532464/db/.s:d12202578089: no such file or directory + testlib.go:32: test directory: "/tmp/testlib_776922352" +_ domaininfo.go:59 DomainInfo.Reload reload: error: open /tmp/testlib_776922352/db: no such file or directory +_ domaininfo.go:84 DomainInfo.write d1: error: open /tmp/testlib_776922352/db/.s:d1562393710: no such file or directory --- PASS: TestDirectoryErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/domaininfo 0.039s +ok blitiri.com.ar/go/chasquid/internal/domaininfo 0.060s === RUN TestUsernameNotSafe --- PASS: TestUsernameNotSafe (0.00s) === RUN TestAutodetect - testlib.go:32: test directory: "/tmp/testlib_1779674462" + testlib.go:32: test directory: "/tmp/testlib_4140874137" --- PASS: TestAutodetect (0.00s) === RUN TestReload --- PASS: TestReload (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/dovecot 0.016s +ok blitiri.com.ar/go/chasquid/internal/dovecot 0.052s === RUN TestSplit --- PASS: TestSplit (0.00s) === RUN TestDomainIn @@ -1763,13 +1799,13 @@ === RUN TestAddHeader --- PASS: TestAddHeader (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/envelope 0.012s +ok blitiri.com.ar/go/chasquid/internal/envelope 0.028s === RUN TestHandler --- PASS: TestHandler (0.00s) === RUN TestMapLabelAccident --- PASS: TestMapLabelAccident (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/expvarom 0.016s +ok blitiri.com.ar/go/chasquid/internal/expvarom 0.054s === RUN TestNoNewline --- PASS: TestNoNewline (0.00s) === RUN TestBasic @@ -1794,21 +1830,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.015s +ok blitiri.com.ar/go/chasquid/internal/haproxy 0.040s === RUN TestBadServer - asm_arm64.s:1223: FakeServer &{{0x40001d4e00}}: accepted - asm_arm64.s:1223: FakeServer &{{0x40001d4e00}}: readRequest: "" "" / EOF - asm_arm64.s:1223: FakeServer &{{0x40001d4e00}}: writeMessage("xxx"): 0 write unix /tmp/rpc-test-1757087229/rpc.sock->@: write: broken pipe - asm_arm64.s:1223: FakeServer &{{0x40001d4e00}}: closing - asm_arm64.s:1223: FakeServer &{{0x4000286480}}: accepted - asm_arm64.s:1223: FakeServer &{{0x4000286480}}: readRequest: "Echo" "" / - asm_arm64.s:1223: FakeServer &{{0x4000286480}}: writeMessage("xxx"): 3 - asm_arm64.s:1223: FakeServer &{{0x4000286480}}: closing ---- PASS: TestBadServer (0.02s) + asm_arm64.s:1223: FakeServer &{{0x4000186480}}: accepted + asm_arm64.s:1223: FakeServer &{{0x4000186480}}: readRequest: "" "" / EOF + asm_arm64.s:1223: FakeServer &{{0x4000186480}}: writeMessage("xxx"): 0 write unix /tmp/rpc-test-3098840492/rpc.sock->@: write: broken pipe + asm_arm64.s:1223: FakeServer &{{0x4000186480}}: closing + asm_arm64.s:1223: FakeServer &{{0x4000186600}}: accepted + asm_arm64.s:1223: FakeServer &{{0x4000186600}}: readRequest: "Echo" "" / + asm_arm64.s:1223: FakeServer &{{0x4000186600}}: writeMessage("xxx"): 3 + asm_arm64.s:1223: FakeServer &{{0x4000186600}}: closing +--- PASS: TestBadServer (0.01s) === RUN TestBadSocket --- PASS: TestBadSocket (0.00s) === RUN TestEndToEnd -_ localrpc.go:63 LocalRPC.Server /tmp/rpc-test-1890761180/sock: Listening +_ localrpc.go:63 LocalRPC.Server /tmp/rpc-test-711548689/sock: Listening === RUN TestEndToEnd/Echo === RUN TestEndToEnd/Echo#01 === RUN TestEndToEnd/Hola @@ -1816,8 +1852,8 @@ _ localrpc.go:139 LocalRPC.Handle @: error: -> 500 test error === RUN TestEndToEnd/UnknownMethod _ localrpc.go:139 LocalRPC.Handle @: error: -> 500 unknown method -_ localrpc.go:67 LocalRPC.Server /tmp/rpc-test-1890761180/sock: error: Accept error: accept unix /tmp/rpc-test-1890761180/sock: use of closed network connection ---- PASS: TestEndToEnd (0.01s) +_ localrpc.go:67 LocalRPC.Server /tmp/rpc-test-711548689/sock: error: Accept error: accept unix /tmp/rpc-test-711548689/sock: use of closed network connection +--- PASS: TestEndToEnd (0.02s) --- PASS: TestEndToEnd/Echo (0.00s) --- PASS: TestEndToEnd/Echo#01 (0.00s) --- PASS: TestEndToEnd/Hola (0.00s) @@ -1831,7 +1867,7 @@ === RUN TestShortReadRequest --- PASS: TestShortReadRequest (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/localrpc 0.047s +ok blitiri.com.ar/go/chasquid/internal/localrpc 0.079s === RUN TestLogger --- PASS: TestLogger (0.00s) === RUN TestDefault @@ -1839,7 +1875,7 @@ === RUN TestFailedLogger --- PASS: TestFailedLogger (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/maillog 0.019s +ok blitiri.com.ar/go/chasquid/internal/maillog 0.055s === RUN TestContext --- PASS: TestContext (0.00s) === RUN TestHistogramBasic @@ -1847,15 +1883,15 @@ === RUN TestHistogramEmpty --- PASS: TestHistogramEmpty (0.00s) === RUN TestHTTP ---- PASS: TestHTTP (0.01s) +--- PASS: TestHTTP (0.02s) === RUN TestHTTPLong --- PASS: TestHTTPLong (0.00s) === RUN TestHTTPErrors ---- PASS: TestHTTPErrors (0.01s) +--- PASS: TestHTTPErrors (0.02s) === RUN TestHTTPUroboro ---- PASS: TestHTTPUroboro (0.01s) +--- PASS: TestHTTPUroboro (0.02s) === RUN TestHTTPDeep ---- PASS: TestHTTPDeep (0.00s) +--- PASS: TestHTTPDeep (0.01s) === RUN TestStripZeros --- PASS: TestStripZeros (0.00s) === RUN TestRegisterHandler @@ -1875,7 +1911,7 @@ === RUN TestFindParent --- PASS: TestFindParent (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/nettrace 0.043s +ok blitiri.com.ar/go/chasquid/internal/nettrace 0.133s === RUN TestUser --- PASS: TestUser (0.00s) === RUN TestDomain @@ -1935,40 +1971,40 @@ --- PASS: FuzzDomainToUnicode/d8637022b61fb5c4df4e153063564accd6331debaafdd594405c320a5e9f2e70 (0.00s) --- PASS: FuzzDomainToUnicode/dc0204d8e2ab058a763873d2a5fede806e95235771ecdd96b56c906886822c19 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/normalize 0.019s +ok blitiri.com.ar/go/chasquid/internal/normalize 0.045s === RUN TestBin - testlib.go:32: test directory: "/tmp/testlib_223139579" + testlib.go:32: test directory: "/tmp/testlib_1256109836" --- PASS: TestBin (0.00s) === RUN TestText - testlib.go:32: test directory: "/tmp/testlib_1028217718" ---- PASS: TestText (0.00s) + testlib.go:32: test directory: "/tmp/testlib_3979973240" +--- PASS: TestText (0.01s) === RUN TestStore - testlib.go:32: test directory: "/tmp/testlib_2232875206" + testlib.go:32: test directory: "/tmp/testlib_3779071207" --- PASS: TestStore (0.00s) === RUN TestFileErrors - testlib.go:32: test directory: "/tmp/testlib_3833126239" + testlib.go:32: test directory: "/tmp/testlib_540719996" --- PASS: TestFileErrors (0.00s) === RUN TestMarshalErrors - testlib.go:32: test directory: "/tmp/testlib_3573619763" + testlib.go:32: test directory: "/tmp/testlib_1608673568" --- PASS: TestMarshalErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/protoio 0.040s +ok blitiri.com.ar/go/chasquid/internal/protoio 0.055s === RUN TestDSN dsn_test.go:49: From: Mail Delivery System To: Subject: Mail delivery failed: returning message to sender - Message-ID: - Date: Thu, 02 Jan 2025 00:02:07 +0000 + Message-ID: + Date: Wed, 04 Feb 2026 06:27:22 +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="luDllWCYk9o" + boundary="DRQBGlixcfs" - --luDllWCYk9o + --DRQBGlixcfs Content-Type: text/plain; charset="utf-8" Content-Disposition: inline Content-Description: Notification @@ -1993,7 +2029,7 @@ oh! the humanity! - --luDllWCYk9o + --DRQBGlixcfs Content-Type: message/global-delivery-status Content-Description: Delivery Report Content-Transfer-Encoding: 8bit @@ -2024,7 +2060,7 @@ - --luDllWCYk9o + --DRQBGlixcfs Content-Type: message/rfc822 Content-Description: Undelivered Message Content-Transfer-Encoding: 8bit @@ -2034,76 +2070,76 @@ Data ñaca. - --luDllWCYk9o-- + --DRQBGlixcfs-- --- PASS: TestDSN (0.00s) === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_4044826048" -_ queue.go:308 Queue.SendLoop pO6-MWJh1CQ: from from -_ queue.go:367 Queue.SendLoop pO6-MWJh1CQ: nodomain sent -_ queue.go:367 Queue.SendLoop pO6-MWJh1CQ: am@loco sent -_ queue.go:367 Queue.SendLoop pO6-MWJh1CQ: x@remote sent -_ queue.go:342 Queue.SendLoop pO6-MWJh1CQ: all done + testlib.go:32: test directory: "/tmp/testlib_3459654457" +_ queue.go:308 Queue.SendLoop 0jCz4pJo57Y: from from +_ queue.go:367 Queue.SendLoop 0jCz4pJo57Y: nodomain sent +_ queue.go:367 Queue.SendLoop 0jCz4pJo57Y: am@loco sent +_ queue.go:367 Queue.SendLoop 0jCz4pJo57Y: x@remote sent +_ queue.go:342 Queue.SendLoop 0jCz4pJo57Y: all done --- PASS: TestBasic (0.00s) === RUN TestDSNOnTimeout - testlib.go:32: test directory: "/tmp/testlib_3923463933" -_ queue.go:308 Queue.SendLoop BL_I3NEAn1w: from from@loco -_ queue.go:467 Queue.SendLoop BL_I3NEAn1w: queued DSN: j5y3mxW9m0I -_ queue.go:342 Queue.SendLoop BL_I3NEAn1w: all done -_ queue.go:308 Queue.SendLoop j5y3mxW9m0I: from <> -_ queue.go:367 Queue.SendLoop j5y3mxW9m0I: from@loco sent -_ queue.go:342 Queue.SendLoop j5y3mxW9m0I: all done + testlib.go:32: test directory: "/tmp/testlib_3975309853" +_ queue.go:308 Queue.SendLoop VSNb3gMWtUk: from from@loco +_ queue.go:467 Queue.SendLoop VSNb3gMWtUk: queued DSN: WLf-yOysS6M +_ queue.go:342 Queue.SendLoop VSNb3gMWtUk: all done +_ queue.go:308 Queue.SendLoop WLf-yOysS6M: from <> +_ queue.go:367 Queue.SendLoop WLf-yOysS6M: from@loco sent +_ queue.go:342 Queue.SendLoop WLf-yOysS6M: all done --- PASS: TestDSNOnTimeout (0.00s) === RUN TestAliases - testlib.go:32: test directory: "/tmp/testlib_4262121521" -_ queue.go:308 Queue.SendLoop AIl6YEp61Rk: from from -_ queue.go:367 Queue.SendLoop AIl6YEp61Rk: ata@hualpa sent -_ queue.go:367 Queue.SendLoop AIl6YEp61Rk: pq@loco sent -_ queue.go:367 Queue.SendLoop AIl6YEp61Rk: rs@loco sent -_ queue.go:342 Queue.SendLoop AIl6YEp61Rk: all done + testlib.go:32: test directory: "/tmp/testlib_4215334627" +_ queue.go:308 Queue.SendLoop 4uUuPA7gj2A: from from +_ queue.go:367 Queue.SendLoop 4uUuPA7gj2A: ata@hualpa sent +_ queue.go:367 Queue.SendLoop 4uUuPA7gj2A: pq@loco sent +_ queue.go:367 Queue.SendLoop 4uUuPA7gj2A: rs@loco sent +_ queue.go:342 Queue.SendLoop 4uUuPA7gj2A: all done --- PASS: TestAliases (0.00s) === RUN TestFullQueue - testlib.go:32: test directory: "/tmp/testlib_4120754937" + testlib.go:32: test directory: "/tmp/testlib_3397880426" _ queue.go:164 Queue.Put from: error: queue full --- PASS: TestFullQueue (0.00s) === RUN TestPipes - testlib.go:32: test directory: "/tmp/testlib_1750830213" -_ queue.go:308 Queue.SendLoop g7ZLeN6o04k: from from -_ queue.go:367 Queue.SendLoop g7ZLeN6o04k: to sent -_ queue.go:375 Queue.SendLoop g7ZLeN6o04k: error: failed to write: open /tmp/testlib_4120754937/.m:g7ZLeN6o04k2341967993: no such file or directory -_ queue.go:342 Queue.SendLoop g7ZLeN6o04k: all done -E queue.go:230 failed to remove queue file "/tmp/testlib_4120754937/m:g7ZLeN6o04k": remove /tmp/testlib_4120754937/m:g7ZLeN6o04k: no such file or directory ---- PASS: TestPipes (0.00s) + testlib.go:32: test directory: "/tmp/testlib_2902079930" +_ queue.go:308 Queue.SendLoop moBlw-vaXLo: from from +_ queue.go:367 Queue.SendLoop moBlw-vaXLo: to sent +_ queue.go:375 Queue.SendLoop moBlw-vaXLo: error: failed to write: open /tmp/testlib_3397880426/.m:moBlw-vaXLo1110485408: no such file or directory +_ queue.go:342 Queue.SendLoop moBlw-vaXLo: all done +E queue.go:230 failed to remove queue file "/tmp/testlib_3397880426/m:moBlw-vaXLo": remove /tmp/testlib_3397880426/m:moBlw-vaXLo: no such file or directory +--- PASS: TestPipes (0.03s) === RUN TestBadPath --- PASS: TestBadPath (0.00s) === RUN TestNextDelay --- PASS: TestNextDelay (0.00s) === RUN TestSerialization - testlib.go:32: test directory: "/tmp/testlib_3456933546" -_ queue.go:308 Queue.SendLoop zp1cfy0xStA: from from@loco -_ queue.go:367 Queue.SendLoop zp1cfy0xStA: to@to sent -_ queue.go:342 Queue.SendLoop zp1cfy0xStA: all done + testlib.go:32: test directory: "/tmp/testlib_3382591682" +_ queue.go:308 Queue.SendLoop qpMtXEwfxx8: from from@loco +_ queue.go:367 Queue.SendLoop qpMtXEwfxx8: to@to sent +_ queue.go:342 Queue.SendLoop qpMtXEwfxx8: all done --- PASS: TestSerialization (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/queue 0.028s +ok blitiri.com.ar/go/chasquid/internal/queue 0.092s === RUN TestWriteFile - testlib.go:32: test directory: "/tmp/testlib_19543251" + testlib.go:32: test directory: "/tmp/testlib_3154096099" --- PASS: TestWriteFile (0.00s) === RUN TestWriteFileWithOp - testlib.go:32: test directory: "/tmp/testlib_1525294525" + testlib.go:32: test directory: "/tmp/testlib_3582035780" --- PASS: TestWriteFileWithOp (0.00s) === RUN TestWriteFileWithFailingOp - testlib.go:32: test directory: "/tmp/testlib_684473978" + testlib.go:32: test directory: "/tmp/testlib_2990020479" --- PASS: TestWriteFileWithFailingOp (0.00s) === RUN TestErrors - testlib.go:32: test directory: "/tmp/testlib_3118884550" + testlib.go:32: test directory: "/tmp/testlib_1475501030" --- PASS: TestErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/safeio 0.016s +ok blitiri.com.ar/go/chasquid/internal/safeio 0.045s === RUN TestString --- PASS: TestString (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/set 0.008s +ok blitiri.com.ar/go/chasquid/internal/set 0.040s === RUN TestIsPermanent --- PASS: TestIsPermanent (0.00s) === RUN TestIsASCII @@ -2117,18 +2153,17 @@ === RUN TestFallbackToIDNA --- PASS: TestFallbackToIDNA (0.00s) === RUN TestLineTooLong ---- PASS: TestLineTooLong (0.02s) +--- PASS: TestLineTooLong (0.06s) PASS -ok blitiri.com.ar/go/chasquid/internal/smtp 0.037s +ok blitiri.com.ar/go/chasquid/internal/smtp 0.105s ? blitiri.com.ar/go/chasquid/internal/trace [no test files] -_ server.go:296 Server listening on 127.0.0.1:42671 (submission) -2025-01-02 00:02:08.006350 daemon listening on 127.0.0.1:42671 -_ server.go:296 Server listening on 127.0.0.1:46635 (submission+TLS) -2025-01-02 00:02:08.006430 daemon listening on 127.0.0.1:46635 -_ server.go:296 Server listening on 127.0.0.1:41483 (SMTP) -2025-01-02 00:02:08.006452 daemon listening on 127.0.0.1:41483 +_ server.go:296 Server listening on 127.0.0.1:34191 (submission+TLS) +2026-02-04 06:27:24.292633 daemon listening on 127.0.0.1:34191 +_ server.go:296 Server listening on 127.0.0.1:35821 (SMTP) +2026-02-04 06:27:24.292713 daemon listening on 127.0.0.1:35821 +_ server.go:296 Server listening on 127.0.0.1:41061 (submission) +2026-02-04 06:27:24.292734 daemon listening on 127.0.0.1:41061 === RUN TestSecLevel -_ conn.go:209 SMTP.Conn 127.0.0.1:34726: error: error completing TLS handshake: EOF _ domaininfo.go:117 DomainInfo.Incoming slc: slc incoming level raised: TLS_CLIENT > PLAIN _ domaininfo.go:109 DomainInfo.Incoming slc: error: slc incoming denied: PLAIN < TLS_CLIENT _ conn.go:559 testconn testconn: error: security level check for slc failed (PLAIN) @@ -2144,185 +2179,186 @@ === RUN TestReadUntilDotReadError --- PASS: TestReadUntilDotReadError (0.00s) === RUN TestSimple -_ conn.go:722 SMTP.Conn 127.0.0.1:35474: Queued from from@from to [to@localhost] - YTn_SrbOeaE -2025-01-02 00:02:08.111585 YTn_SrbOeaE from=from@from queued ip=127.0.0.1:35474 to=[to@localhost] -_ queue.go:308 Queue.SendLoop YTn_SrbOeaE: from from@from -_ queue.go:367 Queue.SendLoop YTn_SrbOeaE: testuser@localhost sent -2025-01-02 00:02:08.111808 YTn_SrbOeaE from=from@from to=testuser@localhost sent +_ conn.go:209 SMTP.Conn 127.0.0.1:52590: error: error completing TLS handshake: EOF +_ conn.go:722 SMTP.Conn 127.0.0.1:55348: Queued from from@from to [to@localhost] - 3nyWWFX6Tus +2026-02-04 06:27:24.399066 3nyWWFX6Tus from=from@from queued ip=127.0.0.1:55348 to=[to@localhost] +_ queue.go:308 Queue.SendLoop 3nyWWFX6Tus: from from@from +_ queue.go:367 Queue.SendLoop 3nyWWFX6Tus: testuser@localhost sent +2026-02-04 06:27:24.399162 3nyWWFX6Tus from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop 3nyWWFX6Tus: all done +2026-02-04 06:27:24.399275 3nyWWFX6Tus from=from@from all done --- PASS: TestSimple (0.00s) === RUN TestSimpleTLS -_ queue.go:342 Queue.SendLoop YTn_SrbOeaE: all done -2025-01-02 00:02:08.112195 YTn_SrbOeaE from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:35476: Queued from from@from to [to@localhost] - HCozGw3Pepg -2025-01-02 00:02:08.119177 HCozGw3Pepg from=from@from queued ip=127.0.0.1:35476 to=[to@localhost] -_ queue.go:308 Queue.SendLoop HCozGw3Pepg: from from@from -_ queue.go:367 Queue.SendLoop HCozGw3Pepg: testuser@localhost sent -2025-01-02 00:02:08.119374 HCozGw3Pepg from=from@from to=testuser@localhost sent +_ conn.go:722 SMTP.Conn 127.0.0.1:55352: Queued from from@from to [to@localhost] - bMGQ3WZKPzQ +2026-02-04 06:27:24.409293 bMGQ3WZKPzQ from=from@from queued ip=127.0.0.1:55352 to=[to@localhost] +_ queue.go:308 Queue.SendLoop bMGQ3WZKPzQ: from from@from +_ queue.go:367 Queue.SendLoop bMGQ3WZKPzQ: testuser@localhost sent +2026-02-04 06:27:24.409363 bMGQ3WZKPzQ from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop bMGQ3WZKPzQ: all done +2026-02-04 06:27:24.409457 bMGQ3WZKPzQ from=from@from all done --- PASS: TestSimpleTLS (0.01s) -_ queue.go:342 Queue.SendLoop HCozGw3Pepg: all done -2025-01-02 00:02:08.119655 HCozGw3Pepg from=from@from all done === RUN TestManyEmails -_ conn.go:722 SMTP.Conn 127.0.0.1:35480: Queued from from@from to [to@localhost] - jsSmavc7EQA -2025-01-02 00:02:08.125743 jsSmavc7EQA from=from@from queued ip=127.0.0.1:35480 to=[to@localhost] -_ queue.go:308 Queue.SendLoop jsSmavc7EQA: from from@from -_ queue.go:367 Queue.SendLoop jsSmavc7EQA: testuser@localhost sent -2025-01-02 00:02:08.125921 jsSmavc7EQA from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop jsSmavc7EQA: all done -2025-01-02 00:02:08.126148 jsSmavc7EQA from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:35480: Queued from from@from to [to@localhost] - xRfxJttLQkk -2025-01-02 00:02:08.126908 xRfxJttLQkk from=from@from queued ip=127.0.0.1:35480 to=[to@localhost] -_ queue.go:308 Queue.SendLoop xRfxJttLQkk: from from@from -_ queue.go:367 Queue.SendLoop xRfxJttLQkk: testuser@localhost sent -2025-01-02 00:02:08.127084 xRfxJttLQkk from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop xRfxJttLQkk: all done -2025-01-02 00:02:08.127329 xRfxJttLQkk from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:35480: Queued from from@from to [to@localhost] - vzGJuzxoRvk -2025-01-02 00:02:08.128023 vzGJuzxoRvk from=from@from queued ip=127.0.0.1:35480 to=[to@localhost] -_ queue.go:308 Queue.SendLoop vzGJuzxoRvk: from from@from -_ queue.go:367 Queue.SendLoop vzGJuzxoRvk: testuser@localhost sent -2025-01-02 00:02:08.128481 vzGJuzxoRvk from=from@from to=testuser@localhost sent +_ conn.go:722 SMTP.Conn 127.0.0.1:55368: Queued from from@from to [to@localhost] - Bm9EUytShgM +2026-02-04 06:27:24.417296 Bm9EUytShgM from=from@from queued ip=127.0.0.1:55368 to=[to@localhost] +_ queue.go:308 Queue.SendLoop Bm9EUytShgM: from from@from +_ queue.go:367 Queue.SendLoop Bm9EUytShgM: testuser@localhost sent +2026-02-04 06:27:24.417386 Bm9EUytShgM from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop Bm9EUytShgM: all done +2026-02-04 06:27:24.417486 Bm9EUytShgM from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:55368: Queued from from@from to [to@localhost] - WoSM7fhbgvU +2026-02-04 06:27:24.417754 WoSM7fhbgvU from=from@from queued ip=127.0.0.1:55368 to=[to@localhost] +_ queue.go:308 Queue.SendLoop WoSM7fhbgvU: from from@from +_ queue.go:367 Queue.SendLoop WoSM7fhbgvU: testuser@localhost sent +2026-02-04 06:27:24.417825 WoSM7fhbgvU from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop WoSM7fhbgvU: all done +2026-02-04 06:27:24.417895 WoSM7fhbgvU from=from@from all done +_ conn.go:722 SMTP.Conn 127.0.0.1:55368: Queued from from@from to [to@localhost] - AUFTi68rTlU +2026-02-04 06:27:24.418136 AUFTi68rTlU from=from@from queued ip=127.0.0.1:55368 to=[to@localhost] +_ queue.go:308 Queue.SendLoop AUFTi68rTlU: from from@from +_ queue.go:367 Queue.SendLoop AUFTi68rTlU: testuser@localhost sent +2026-02-04 06:27:24.418209 AUFTi68rTlU from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop AUFTi68rTlU: all done +2026-02-04 06:27:24.418276 AUFTi68rTlU from=from@from all done --- PASS: TestManyEmails (0.01s) -_ queue.go:342 Queue.SendLoop vzGJuzxoRvk: all done === RUN TestAuth -2025-01-02 00:02:08.128688 vzGJuzxoRvk from=from@from all done -2025-01-02 00:02:08.234509 127.0.0.1:33962 auth succeeded for testuser@localhost -_ conn.go:722 SMTP.Conn 127.0.0.1:33962: Queued from testuser@localhost to [to@localhost] - KH2-064t7Rw -2025-01-02 00:02:08.235328 KH2-064t7Rw from=testuser@localhost queued ip=127.0.0.1:33962 to=[to@localhost] -_ queue.go:308 Queue.SendLoop KH2-064t7Rw: from testuser@localhost -_ queue.go:367 Queue.SendLoop KH2-064t7Rw: testuser@localhost sent -2025-01-02 00:02:08.235447 KH2-064t7Rw from=testuser@localhost to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop KH2-064t7Rw: all done -2025-01-02 00:02:08.235576 KH2-064t7Rw from=testuser@localhost all done +2026-02-04 06:27:24.532373 127.0.0.1:54760 auth succeeded for testuser@localhost +_ conn.go:722 SMTP.Conn 127.0.0.1:54760: Queued from testuser@localhost to [to@localhost] - 5XbjOh-SJM4 +2026-02-04 06:27:24.532899 5XbjOh-SJM4 from=testuser@localhost queued ip=127.0.0.1:54760 to=[to@localhost] +_ queue.go:308 Queue.SendLoop 5XbjOh-SJM4: from testuser@localhost +_ queue.go:367 Queue.SendLoop 5XbjOh-SJM4: testuser@localhost sent +2026-02-04 06:27:24.532975 5XbjOh-SJM4 from=testuser@localhost to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop 5XbjOh-SJM4: all done +2026-02-04 06:27:24.533071 5XbjOh-SJM4 from=testuser@localhost all done --- PASS: TestAuth (0.11s) === RUN TestSubmissionWithoutAuth -_ conn.go:318 SMTP.Conn 127.0.0.1:33966: error: MAIL failed: 550 5.7.9 Mail to submission port must be authenticated ---- PASS: TestSubmissionWithoutAuth (0.01s) +_ conn.go:318 SMTP.Conn 127.0.0.1:54772: error: MAIL failed: 550 5.7.9 Mail to submission port must be authenticated +--- PASS: TestSubmissionWithoutAuth (0.00s) === RUN TestAuthOnTLS -2025-01-02 00:02:08.348114 127.0.0.1:34740 auth succeeded for testuser@localhost -_ conn.go:722 SMTP.Conn 127.0.0.1:34740: Queued from testuser@localhost to [to@localhost] - _tE1aQwIIjA -2025-01-02 00:02:08.349100 _tE1aQwIIjA from=testuser@localhost queued ip=127.0.0.1:34740 to=[to@localhost] -_ queue.go:308 Queue.SendLoop _tE1aQwIIjA: from testuser@localhost -_ queue.go:367 Queue.SendLoop _tE1aQwIIjA: testuser@localhost sent -2025-01-02 00:02:08.349339 _tE1aQwIIjA from=testuser@localhost to=testuser@localhost sent +2026-02-04 06:27:24.644373 127.0.0.1:52604 auth succeeded for testuser@localhost +_ conn.go:722 SMTP.Conn 127.0.0.1:52604: Queued from testuser@localhost to [to@localhost] - C077EpdRaac +2026-02-04 06:27:24.644899 C077EpdRaac from=testuser@localhost queued ip=127.0.0.1:52604 to=[to@localhost] +_ queue.go:308 Queue.SendLoop C077EpdRaac: from testuser@localhost +_ queue.go:367 Queue.SendLoop C077EpdRaac: testuser@localhost sent +2026-02-04 06:27:24.644966 C077EpdRaac from=testuser@localhost to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop C077EpdRaac: all done +2026-02-04 06:27:24.645062 C077EpdRaac from=testuser@localhost all done --- PASS: TestAuthOnTLS (0.11s) === RUN TestAuthOnSMTP -_ queue.go:342 Queue.SendLoop _tE1aQwIIjA: all done -2025-01-02 00:02:08.349642 _tE1aQwIIjA from=testuser@localhost all done -2025-01-02 00:02:08.456778 127.0.0.1:35486 auth succeeded for testuser@localhost -_ conn.go:722 SMTP.Conn 127.0.0.1:35486: Queued from testuser@localhost to [to@localhost] - fmV1YB9uwzQ -2025-01-02 00:02:08.457854 fmV1YB9uwzQ from=testuser@localhost queued ip=127.0.0.1:35486 to=[to@localhost] -_ queue.go:308 Queue.SendLoop fmV1YB9uwzQ: from testuser@localhost -_ queue.go:367 Queue.SendLoop fmV1YB9uwzQ: testuser@localhost sent -2025-01-02 00:02:08.458117 fmV1YB9uwzQ from=testuser@localhost to=testuser@localhost sent +2026-02-04 06:27:24.756383 127.0.0.1:55384 auth succeeded for testuser@localhost +_ conn.go:722 SMTP.Conn 127.0.0.1:55384: Queued from testuser@localhost to [to@localhost] - tjQAFXxZBYQ +2026-02-04 06:27:24.756907 tjQAFXxZBYQ from=testuser@localhost queued ip=127.0.0.1:55384 to=[to@localhost] +_ queue.go:308 Queue.SendLoop tjQAFXxZBYQ: from testuser@localhost +_ queue.go:367 Queue.SendLoop tjQAFXxZBYQ: testuser@localhost sent +2026-02-04 06:27:24.756977 tjQAFXxZBYQ from=testuser@localhost to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop tjQAFXxZBYQ: all done +2026-02-04 06:27:24.757075 tjQAFXxZBYQ from=testuser@localhost all done --- PASS: TestAuthOnSMTP (0.11s) -_ queue.go:342 Queue.SendLoop fmV1YB9uwzQ: all done -2025-01-02 00:02:08.458418 fmV1YB9uwzQ from=testuser@localhost all done === RUN TestBrokenAuth -_ conn.go:1193 SMTP.Conn 127.0.0.1:33978: error: error authenticating \"user\"@\"broken\": failed to auth -2025-01-02 00:02:08.571089 127.0.0.1:33978 auth failed for user@broken -_ conn.go:318 SMTP.Conn 127.0.0.1:33978: error: AUTH failed: 454 4.7.0 Temporary authentication failure -_ conn.go:318 SMTP.Conn 127.0.0.1:33978: error: unknown<\"*\"> failed: 500 5.5.1 Unknown command ---- PASS: TestBrokenAuth (0.11s) +_ conn.go:1193 SMTP.Conn 127.0.0.1:54776: error: error authenticating \"user\"@\"broken\": failed to auth +2026-02-04 06:27:24.872449 127.0.0.1:54776 auth failed for user@broken +_ conn.go:318 SMTP.Conn 127.0.0.1:54776: error: AUTH failed: 454 4.7.0 Temporary authentication failure +_ conn.go:318 SMTP.Conn 127.0.0.1:54776: error: unknown<\"*\"> failed: 500 5.5.1 Unknown command +--- PASS: TestBrokenAuth (0.12s) === RUN TestWrongMailParsing -_ conn.go:318 SMTP.Conn 127.0.0.1:35500: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:35500: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:35500: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:35500: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:35508: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:35508: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:35508: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:35508: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:35512: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:35512: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:35512: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:35512: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:35522: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:35522: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:35522: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:35522: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:35530: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:35530: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:35530: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:35530: error: too many errors, breaking connection -_ conn.go:318 SMTP.Conn 127.0.0.1:35544: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:318 SMTP.Conn 127.0.0.1:35544: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:318 SMTP.Conn 127.0.0.1:35544: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:325 SMTP.Conn 127.0.0.1:35544: error: too many errors, breaking connection ---- PASS: TestWrongMailParsing (0.01s) +_ conn.go:318 SMTP.Conn 127.0.0.1:55386: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:55386: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:55386: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:55386: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:55392: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:55392: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:55392: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:55392: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:55404: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:55404: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:55404: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:55404: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:55420: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:55420: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:55420: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:55420: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:55428: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:55428: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:55428: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:55428: error: too many errors, breaking connection +_ conn.go:318 SMTP.Conn 127.0.0.1:55430: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:318 SMTP.Conn 127.0.0.1:55430: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:318 SMTP.Conn 127.0.0.1:55430: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:325 SMTP.Conn 127.0.0.1:55430: 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:35564: error: RCPT failed: 503 5.5.1 Sender not yet given +_ conn.go:318 SMTP.Conn 127.0.0.1:55454: error: RCPT failed: 503 5.5.1 Sender not yet given --- PASS: TestRcptBeforeMail (0.00s) === RUN TestRcptOption --- PASS: TestRcptOption (0.01s) === RUN TestRelayForbidden -2025-01-02 00:02:08.586275 127.0.0.1:35588 rejected from=from@somewhere to=[to@somewhere] - relay not allowed -_ conn.go:318 SMTP.Conn 127.0.0.1:35588: error: RCPT failed: 503 5.7.1 Relay not allowed ---- PASS: TestRelayForbidden (0.00s) +2026-02-04 06:27:24.896575 127.0.0.1:55462 rejected from=from@somewhere to=[to@somewhere] - relay not allowed +_ conn.go:318 SMTP.Conn 127.0.0.1:55462: error: RCPT failed: 503 5.7.1 Relay not allowed +--- PASS: TestRelayForbidden (0.01s) === RUN TestTooManyRecipients -2025-01-02 00:02:08.694338 127.0.0.1:33980 auth succeeded for testuser@localhost -_ conn.go:318 SMTP.Conn 127.0.0.1:33980: error: RCPT failed: 452 4.5.3 Too many recipients ---- PASS: TestTooManyRecipients (0.11s) +2026-02-04 06:27:25.004778 127.0.0.1:54782 auth succeeded for testuser@localhost +_ conn.go:318 SMTP.Conn 127.0.0.1:54782: error: RCPT failed: 452 4.5.3 Too many recipients +--- PASS: TestTooManyRecipients (0.12s) === RUN TestRcptBrokenExists -_ conn.go:622 SMTP.Conn 127.0.0.1:35594: error: error checking if user \"to@broken\" exists: failed to check if user exists -2025-01-02 00:02:08.705410 127.0.0.1:35594 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:35594: error: RCPT failed: 451 4.4.3 Temporary error checking address ---- PASS: TestRcptBrokenExists (0.01s) +_ conn.go:622 SMTP.Conn 127.0.0.1:55476: error: error checking if user \"to@broken\" exists: failed to check if user exists +2026-02-04 06:27:25.017476 127.0.0.1:55476 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:55476: error: RCPT failed: 451 4.4.3 Temporary error checking address +--- PASS: TestRcptBrokenExists (0.00s) === RUN TestRcptUserDoesNotExist -2025-01-02 00:02:08.711146 127.0.0.1:35604 rejected from=from@localhost to=[doesnotexist@localhost] - local user does not exist -_ conn.go:318 SMTP.Conn 127.0.0.1:35604: error: RCPT failed: 550 5.1.1 Destination address is unknown (user does not exist) ---- PASS: TestRcptUserDoesNotExist (0.01s) +2026-02-04 06:27:25.019686 127.0.0.1:55482 rejected from=from@localhost to=[doesnotexist@localhost] - local user does not exist +_ conn.go:318 SMTP.Conn 127.0.0.1:55482: 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:35620: Queued from from@from to [to@localhost] - m_1uzshN5j8 -2025-01-02 00:02:08.908595 m_1uzshN5j8 from=from@from queued ip=127.0.0.1:35620 to=[to@localhost] -_ queue.go:308 Queue.SendLoop m_1uzshN5j8: from from@from -_ queue.go:367 Queue.SendLoop m_1uzshN5j8: testuser@localhost sent -2025-01-02 00:02:08.908825 m_1uzshN5j8 from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop m_1uzshN5j8: all done -2025-01-02 00:02:08.933693 m_1uzshN5j8 from=from@from all done -_ conn.go:722 SMTP.Conn 127.0.0.1:35620: Queued from from@from to [to@localhost] - eVVWBO74xgA -2025-01-02 00:02:09.121447 eVVWBO74xgA from=from@from queued ip=127.0.0.1:35620 to=[to@localhost] -_ queue.go:308 Queue.SendLoop eVVWBO74xgA: from from@from -_ queue.go:367 Queue.SendLoop eVVWBO74xgA: testuser@localhost sent -2025-01-02 00:02:09.121614 eVVWBO74xgA from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop eVVWBO74xgA: all done -2025-01-02 00:02:09.148760 eVVWBO74xgA from=from@from all done -_ conn.go:318 SMTP.Conn 127.0.0.1:35620: error: DATA failed: 552 5.3.4 Message too big -_ conn.go:722 SMTP.Conn 127.0.0.1:35620: Queued from from@from to [to@localhost] - IO6rpIOvb18 -2025-01-02 00:02:09.324007 IO6rpIOvb18 from=from@from queued ip=127.0.0.1:35620 to=[to@localhost] -_ queue.go:308 Queue.SendLoop IO6rpIOvb18: from from@from -_ queue.go:367 Queue.SendLoop IO6rpIOvb18: testuser@localhost sent -2025-01-02 00:02:09.324144 IO6rpIOvb18 from=from@from to=testuser@localhost sent ---- PASS: TestTooMuchData (0.61s) +_ conn.go:722 SMTP.Conn 127.0.0.1:55486: Queued from from@from to [to@localhost] - _PxS1N6c5P8 +2026-02-04 06:27:25.243562 _PxS1N6c5P8 from=from@from queued ip=127.0.0.1:55486 to=[to@localhost] +_ queue.go:308 Queue.SendLoop _PxS1N6c5P8: from from@from +_ queue.go:367 Queue.SendLoop _PxS1N6c5P8: testuser@localhost sent +2026-02-04 06:27:25.243735 _PxS1N6c5P8 from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop _PxS1N6c5P8: all done +2026-02-04 06:27:25.291021 _PxS1N6c5P8 from=from@from all done +_ queue.go:308 Queue.SendLoop fZ8CucJKONQ: from from@from +_ queue.go:367 Queue.SendLoop fZ8CucJKONQ: testuser@localhost sent +2026-02-04 06:27:25.480499 fZ8CucJKONQ from=from@from to=testuser@localhost sent +_ conn.go:722 SMTP.Conn 127.0.0.1:55486: Queued from from@from to [to@localhost] - fZ8CucJKONQ +2026-02-04 06:27:25.488857 fZ8CucJKONQ from=from@from queued ip=127.0.0.1:55486 to=[to@localhost] +_ queue.go:342 Queue.SendLoop fZ8CucJKONQ: all done +2026-02-04 06:27:25.512211 fZ8CucJKONQ from=from@from all done +_ conn.go:318 SMTP.Conn 127.0.0.1:55486: error: DATA failed: 552 5.3.4 Message too big +_ conn.go:722 SMTP.Conn 127.0.0.1:55486: Queued from from@from to [to@localhost] - HdwAKSSYny4 +2026-02-04 06:27:25.873287 HdwAKSSYny4 from=from@from queued ip=127.0.0.1:55486 to=[to@localhost] +_ queue.go:308 Queue.SendLoop HdwAKSSYny4: from from@from +_ queue.go:367 Queue.SendLoop HdwAKSSYny4: testuser@localhost sent +2026-02-04 06:27:25.884521 HdwAKSSYny4 from=from@from to=testuser@localhost sent +--- PASS: TestTooMuchData (0.88s) === RUN TestSimpleCommands -_ conn.go:318 SMTP.Conn 127.0.0.1:35630: 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:35630: error: EXPN failed: 502 5.5.1 You feel disoriented for a moment. ---- PASS: TestSimpleCommands (0.00s) +_ queue.go:342 Queue.SendLoop HdwAKSSYny4: all done +2026-02-04 06:27:25.906245 HdwAKSSYny4 from=from@from all done +_ conn.go:318 SMTP.Conn 127.0.0.1:55500: 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:55500: error: EXPN failed: 502 5.5.1 You feel disoriented for a moment. +--- PASS: TestSimpleCommands (0.01s) === RUN TestLongLines -_ conn.go:318 SMTP.Conn 127.0.0.1:35632: error: unknown<\"\"> failed: 500 5.5.1 Unknown command -_ conn.go:348 SMTP.Conn 127.0.0.1:35632: error: exiting with error: line too long +_ conn.go:318 SMTP.Conn 127.0.0.1:55506: error: unknown<\"\"> failed: 500 5.5.1 Unknown command +_ conn.go:348 SMTP.Conn 127.0.0.1:55506: 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:35650: error: STARTTLS failed: 503 5.5.1 You are already wearing that! +_ conn.go:318 SMTP.Conn 127.0.0.1:55514: 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:34748: error: STARTTLS failed: 503 5.5.1 You are already wearing that! ---- PASS: TestStartTLSOnTLS (0.00s) +_ conn.go:318 SMTP.Conn 127.0.0.1:52620: error: STARTTLS failed: 503 5.5.1 You are already wearing that! +--- PASS: TestStartTLSOnTLS (0.01s) === RUN TestAddDKIMSigner - testlib.go:32: test directory: "/tmp/testlib_1488090481" -_ queue.go:342 Queue.SendLoop IO6rpIOvb18: all done -2025-01-02 00:02:09.336612 IO6rpIOvb18 from=from@from all done ---- PASS: TestAddDKIMSigner (0.01s) + testlib.go:32: test directory: "/tmp/testlib_4286746273" +--- PASS: TestAddDKIMSigner (0.00s) === RUN FuzzConnection --- PASS: FuzzConnection (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/smtpsrv 1.505s +ok blitiri.com.ar/go/chasquid/internal/smtpsrv 1.938s === RUN TestParsePolicy sts_test.go:90: pol1: &{Version:STSv1 Mode:enforce MXs:[*.mail.example.com] MaxAge:34h17m36s} ---- PASS: TestParsePolicy (0.00s) +--- PASS: TestParsePolicy (0.01s) === RUN TestCheckPolicy --- PASS: TestCheckPolicy (0.00s) === RUN TestMatchDomain @@ -2337,16 +2373,16 @@ --- PASS: TestFetch (0.00s) === RUN TestPolicyTooBig sts_test.go:242: got error as expected: MTA-STS TXT record missing ---- PASS: TestPolicyTooBig (0.01s) +--- PASS: TestPolicyTooBig (0.09s) === RUN TestCacheBasics - testlib.go:32: test directory: "/tmp/testlib_1996966503" + testlib.go:32: test directory: "/tmp/testlib_3762949920" 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_807297626" + testlib.go:32: test directory: "/tmp/testlib_1663573259" 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} @@ -2355,13 +2391,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_3112423787" + testlib.go:32: test directory: "/tmp/testlib_4195921290" 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_1090876735" + testlib.go:32: test directory: "/tmp/testlib_2887384046" sts_test.go:464: recovered: domain contains slash --- PASS: TestCacheSlashSafe (0.00s) === RUN TestURLForDomain @@ -2371,9 +2407,9 @@ === RUN TestHTTPGet --- PASS: TestHTTPGet (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/sts 0.046s +ok blitiri.com.ar/go/chasquid/internal/sts 0.157s === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_1625574852" + testlib.go:32: test directory: "/tmp/testlib_3630536679" --- PASS: TestBasic (0.00s) === RUN TestRemoveCheck testlib_test.go:33: recovered: invalid/dangerous directory @@ -2384,54 +2420,54 @@ testlib_test.go:60: recovered: invalid/dangerous path --- PASS: TestRewriteSafeguard (0.00s) === RUN TestRewrite - testlib.go:32: test directory: "/tmp/testlib_3375341126" + testlib.go:32: test directory: "/tmp/testlib_1878474033" --- 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_1391285005" + testlib.go:32: test directory: "/tmp/testlib_4093261262" --- PASS: TestGenerateCert (0.05s) === RUN TestGenerateCertBadDir ---- PASS: TestGenerateCertBadDir (0.05s) +--- PASS: TestGenerateCertBadDir (0.06s) PASS -ok blitiri.com.ar/go/chasquid/internal/testlib 0.140s +ok blitiri.com.ar/go/chasquid/internal/testlib 0.172s === RUN TestVersionName --- PASS: TestVersionName (0.00s) === RUN TestCipherSuiteName --- PASS: TestCipherSuiteName (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/tlsconst 0.009s +ok blitiri.com.ar/go/chasquid/internal/tlsconst 0.036s === RUN TestEmptyLoad - userdb_test.go:37: file: "/tmp/userdb_test3883313560" - userdb_test.go:37: file: "/tmp/userdb_test972171623" + userdb_test.go:37: file: "/tmp/userdb_test3493881474" + userdb_test.go:37: file: "/tmp/userdb_test3748230155" --- PASS: TestEmptyLoad (0.00s) === RUN TestWrite - userdb_test.go:37: file: "/tmp/userdb_test3903711257" ---- PASS: TestWrite (0.56s) + userdb_test.go:37: file: "/tmp/userdb_test3518181965" +--- PASS: TestWrite (0.61s) === RUN TestNew ---- PASS: TestNew (0.10s) +--- PASS: TestNew (0.05s) === RUN TestInvalidUsername - userdb_test.go:37: file: "/tmp/userdb_test3316143769" + userdb_test.go:37: file: "/tmp/userdb_test943083914" --- PASS: TestInvalidUsername (0.00s) === RUN TestPlainScheme - userdb_test.go:37: file: "/tmp/userdb_test2761194433" + userdb_test.go:37: file: "/tmp/userdb_test45277502" --- PASS: TestPlainScheme (0.00s) === RUN TestDeniedScheme - userdb_test.go:37: file: "/tmp/userdb_test608026948" + userdb_test.go:37: file: "/tmp/userdb_test1640892866" --- PASS: TestDeniedScheme (0.00s) === RUN TestReload - userdb_test.go:37: file: "/tmp/userdb_test2568843355" + userdb_test.go:37: file: "/tmp/userdb_test3659036116" --- PASS: TestReload (0.00s) === RUN TestRemoveUser - userdb_test.go:37: file: "/tmp/userdb_test188680443" ---- PASS: TestRemoveUser (0.09s) + userdb_test.go:37: file: "/tmp/userdb_test3035686495" +--- PASS: TestRemoveUser (0.07s) === RUN TestExists - userdb_test.go:37: file: "/tmp/userdb_test2688554842" + userdb_test.go:37: file: "/tmp/userdb_test451015367" --- PASS: TestExists (0.10s) PASS -ok blitiri.com.ar/go/chasquid/internal/userdb 0.870s +ok blitiri.com.ar/go/chasquid/internal/userdb 0.868s create-stamp debian/debhelper-build-stamp dh_testroot -O--buildsystem=golang dh_prep -O--buildsystem=golang @@ -2485,8 +2521,8 @@ dpkg-gencontrol: warning: package chasquid: substitution variable ${misc:Static-Built-Using} unused, but is defined dh_md5sums -O--buildsystem=golang dh_builddeb -O--buildsystem=golang -dpkg-deb: building package 'chasquid' in '../chasquid_1.14.0-2_arm64.deb'. dpkg-deb: building package 'chasquid-dbgsym' in '../chasquid-dbgsym_1.14.0-2_arm64.deb'. +dpkg-deb: building package 'chasquid' in '../chasquid_1.14.0-2_arm64.deb'. dpkg-genbuildinfo --build=binary -O../chasquid_1.14.0-2_arm64.buildinfo dpkg-genchanges --build=binary -O../chasquid_1.14.0-2_arm64.changes dpkg-genchanges: info: binary-only upload (no source code included) @@ -2494,12 +2530,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: not including original source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/567331/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/567331/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/1716266 and its subdirectories -I: Current time: Wed Jan 1 12:02:29 -12 2025 -I: pbuilder-time-stamp: 1735776149 +I: removing directory /srv/workspace/pbuilder/567331 and its subdirectories +I: Current time: Wed Feb 4 20:27:55 +14 2026 +I: pbuilder-time-stamp: 1770186475