Diff of the two buildlogs: -- --- b1/build.log 2024-04-18 09:59:00.146496915 +0000 +++ b2/build.log 2024-04-18 10:02:44.556947041 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed Apr 17 21:52:27 -12 2024 -I: pbuilder-time-stamp: 1713433947 +I: Current time: Thu Apr 18 23:59:15 +14 2024 +I: pbuilder-time-stamp: 1713434355 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -27,52 +27,84 @@ dpkg-source: info: applying 0001-Use_chasquid_user.patch I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/26326/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/1634/tmp/hooks/D01_modify_environment starting +debug: Running on virt64z. +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 Apr 18 09:59 /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/1634/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/1634/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='armhf' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=3 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='armhf' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="21" [3]="1" [4]="release" [5]="arm-unknown-linux-gnueabihf") + BASH_VERSION='5.2.21(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=armhf + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=4 ' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=arm + HOST_ARCH=armhf IFS=' ' - INVOCATION_ID='9431631aeac644168e222727722c3520' - 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='26326' - PS1='# ' - PS2='> ' + INVOCATION_ID=0691eaf8203b4acba71373768e84b7cf + LANG=C + LANGUAGE=it_CH:it + LC_ALL=C + MACHTYPE=arm-unknown-linux-gnueabihf + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnueabihf + 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=1634 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.YLi5xbRR/pbuilderrc_1Okf --distribution trixie --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.YLi5xbRR/b1 --logfile b1/build.log chasquid_1.13-1.dsc' - SUDO_GID='113' - SUDO_UID='107' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://10.0.0.15:3142/' + 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.YLi5xbRR/pbuilderrc_UfnU --distribution trixie --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.YLi5xbRR/b2 --logfile b2/build.log chasquid_1.13-1.dsc' + SUDO_GID=110 + SUDO_UID=103 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://10.0.0.15:3142/ I: uname -a - Linux ff4a 6.1.0-20-armmp-lpae #1 SMP Debian 6.1.85-1 (2024-04-11) armv7l GNU/Linux + Linux i-capture-the-hostname 6.1.0-20-arm64 #1 SMP Debian 6.1.85-1 (2024-04-11) aarch64 GNU/Linux I: ls -l /bin lrwxrwxrwx 1 root root 7 Apr 17 11:24 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/26326/tmp/hooks/D02_print_environment finished +I: user script /srv/workspace/pbuilder/1634/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -176,7 +208,7 @@ Get: 44 http://deb.debian.org/debian trixie/main armhf golang-blitiri-go-log-dev all 1.1.0-1 [6724 B] Get: 45 http://deb.debian.org/debian trixie/main armhf golang-blitiri-go-spf-dev all 1.5.1-1 [37.2 kB] Get: 46 http://deb.debian.org/debian trixie/main armhf golang-blitiri-go-systemd-dev all 1.1.0-1 [6952 B] -Fetched 66.4 MB in 4s (16.0 MB/s) +Fetched 66.4 MB in 1s (67.8 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package sensible-utils. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 19635 files and directories currently installed.) @@ -375,7 +407,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/chasquid-1.13/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-genchanges -S > ../chasquid_1.13-1_source.changes +I: user script /srv/workspace/pbuilder/1634/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/1634/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/chasquid-1.13/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-genchanges -S > ../chasquid_1.13-1_source.changes dpkg-buildpackage: info: source package chasquid dpkg-buildpackage: info: source version 1.13-1 dpkg-buildpackage: info: source distribution unstable @@ -395,28 +431,28 @@ debian/rules override_dh_auto_build make[1]: Entering directory '/build/reproducible-path/chasquid-1.13' dh_auto_build -- -ldflags " -X main.version=1.13-1 -X main.sourceDateTs=1703600557" - cd obj-arm-linux-gnueabihf && go install -trimpath -v -p 3 -ldflags " -X main.version=1.13-1 -X main.sourceDateTs=1703600557" blitiri.com.ar/go/chasquid blitiri.com.ar/go/chasquid/cmd/chasquid-util blitiri.com.ar/go/chasquid/cmd/mda-lmtp blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/aliases blitiri.com.ar/go/chasquid/internal/auth blitiri.com.ar/go/chasquid/internal/config blitiri.com.ar/go/chasquid/internal/courier blitiri.com.ar/go/chasquid/internal/domaininfo blitiri.com.ar/go/chasquid/internal/dovecot blitiri.com.ar/go/chasquid/internal/envelope blitiri.com.ar/go/chasquid/internal/expvarom blitiri.com.ar/go/chasquid/internal/haproxy blitiri.com.ar/go/chasquid/internal/localrpc blitiri.com.ar/go/chasquid/internal/maillog blitiri.com.ar/go/chasquid/internal/nettrace blitiri.com.ar/go/chasquid/internal/normalize blitiri.com.ar/go/chasquid/internal/protoio blitiri.com.ar/go/chasquid/internal/protoio/testpb blitiri.com.ar/go/chasquid/internal/queue blitiri.com.ar/go/chasquid/internal/safeio blitiri.com.ar/go/chasquid/internal/set blitiri.com.ar/go/chasquid/internal/smtp blitiri.com.ar/go/chasquid/internal/smtpsrv blitiri.com.ar/go/chasquid/internal/sts blitiri.com.ar/go/chasquid/internal/testlib blitiri.com.ar/go/chasquid/internal/tlsconst blitiri.com.ar/go/chasquid/internal/trace blitiri.com.ar/go/chasquid/internal/userdb -internal/goarch -encoding + cd obj-arm-linux-gnueabihf && go install -trimpath -v -p 4 -ldflags " -X main.version=1.13-1 -X main.sourceDateTs=1703600557" blitiri.com.ar/go/chasquid blitiri.com.ar/go/chasquid/cmd/chasquid-util blitiri.com.ar/go/chasquid/cmd/mda-lmtp blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/aliases blitiri.com.ar/go/chasquid/internal/auth blitiri.com.ar/go/chasquid/internal/config blitiri.com.ar/go/chasquid/internal/courier blitiri.com.ar/go/chasquid/internal/domaininfo blitiri.com.ar/go/chasquid/internal/dovecot blitiri.com.ar/go/chasquid/internal/envelope blitiri.com.ar/go/chasquid/internal/expvarom blitiri.com.ar/go/chasquid/internal/haproxy blitiri.com.ar/go/chasquid/internal/localrpc blitiri.com.ar/go/chasquid/internal/maillog blitiri.com.ar/go/chasquid/internal/nettrace blitiri.com.ar/go/chasquid/internal/normalize blitiri.com.ar/go/chasquid/internal/protoio blitiri.com.ar/go/chasquid/internal/protoio/testpb blitiri.com.ar/go/chasquid/internal/queue blitiri.com.ar/go/chasquid/internal/safeio blitiri.com.ar/go/chasquid/internal/set blitiri.com.ar/go/chasquid/internal/smtp blitiri.com.ar/go/chasquid/internal/smtpsrv blitiri.com.ar/go/chasquid/internal/sts blitiri.com.ar/go/chasquid/internal/testlib blitiri.com.ar/go/chasquid/internal/tlsconst blitiri.com.ar/go/chasquid/internal/trace blitiri.com.ar/go/chasquid/internal/userdb internal/unsafeheader +encoding +internal/goarch internal/cpu -internal/chacha8rand -internal/abi -internal/bytealg internal/coverage/rtcov internal/godebugs +internal/abi +internal/chacha8rand internal/goexperiment internal/goos -runtime/internal/atomic runtime/internal/math runtime/internal/sys runtime/internal/syscall internal/itoa +internal/bytealg +runtime/internal/atomic math/bits unicode/utf8 internal/race -math sync/atomic +math unicode runtime cmp @@ -437,55 +473,65 @@ crypto/subtle sync internal/testlog -internal/bisect internal/singleflight +internal/bisect +google.golang.org/protobuf/internal/pragma runtime/cgo -internal/godebug errors sort +internal/godebug strconv io -reflect internal/oserror syscall -internal/syscall/unix -time internal/safefilepath -internal/syscall/execenv path +reflect strings -internal/fmtsort vendor/golang.org/x/net/dns/dnsmessage -internal/poll -io/fs -context -os +internal/syscall/unix +time +internal/syscall/execenv internal/intern -encoding/binary net/netip hash hash/fnv bytes -google.golang.org/protobuf/internal/pragma hash/crc32 -encoding/base64 +internal/fmtsort +encoding/binary +html +internal/poll +io/fs +context bufio +encoding/base64 embed +regexp/syntax +math/rand +os +crypto +crypto/cipher +crypto/internal/randutil +crypto/internal/edwards25519/field +crypto/internal/boring +crypto/aes +crypto/des +crypto/internal/nistec/fiat +crypto/sha512 +regexp +crypto/internal/edwards25519 fmt -net path/filepath +net google.golang.org/protobuf/internal/detrand -io/ioutil -blitiri.com.ar/go/chasquid/internal/safeio -html flag log google.golang.org/protobuf/internal/errors -go/token google.golang.org/protobuf/encoding/protowire +go/token google.golang.org/protobuf/reflect/protoreflect compress/flate -compress/gzip google.golang.org/protobuf/internal/encoding/messageset google.golang.org/protobuf/internal/strs google.golang.org/protobuf/internal/genid @@ -494,115 +540,105 @@ google.golang.org/protobuf/reflect/protoregistry google.golang.org/protobuf/runtime/protoiface google.golang.org/protobuf/internal/descfmt -google.golang.org/protobuf/proto google.golang.org/protobuf/internal/descopts +google.golang.org/protobuf/proto google.golang.org/protobuf/internal/encoding/defval +compress/gzip encoding/json -google.golang.org/protobuf/encoding/prototext -google.golang.org/protobuf/internal/filedesc +io/ioutil google.golang.org/protobuf/internal/version +blitiri.com.ar/go/chasquid/internal/safeio net/url +google.golang.org/protobuf/encoding/prototext +google.golang.org/protobuf/internal/filedesc blitiri.com.ar/go/chasquid/internal/protoio -regexp/syntax -google.golang.org/protobuf/internal/encoding/tag -regexp -google.golang.org/protobuf/internal/impl text/template/parse -text/template -log/syslog -blitiri.com.ar/go/log -math/rand -crypto -crypto/cipher -crypto/internal/boring -html/template -crypto/internal/randutil math/big -crypto/aes -crypto/des -crypto/internal/edwards25519/field -crypto/internal/nistec/fiat +text/template +google.golang.org/protobuf/internal/encoding/tag +google.golang.org/protobuf/internal/impl crypto/rand -google.golang.org/protobuf/internal/filetype +html/template +crypto/internal/nistec +crypto/ecdh +crypto/elliptic crypto/internal/bigmod -google.golang.org/protobuf/runtime/protoimpl crypto/internal/boring/bbig -blitiri.com.ar/go/chasquid/internal/config -crypto/sha512 encoding/asn1 -crypto/internal/edwards25519 crypto/ed25519 -vendor/golang.org/x/crypto/cryptobyte crypto/hmac crypto/md5 crypto/rc4 +vendor/golang.org/x/crypto/cryptobyte crypto/rsa crypto/sha1 +crypto/ecdsa crypto/sha256 -crypto/internal/nistec crypto/dsa +log/syslog encoding/hex encoding/pem crypto/x509/pkix +blitiri.com.ar/go/log vendor/golang.org/x/crypto/chacha20 +crypto/x509 vendor/golang.org/x/crypto/internal/poly1305 vendor/golang.org/x/crypto/hkdf -vendor/golang.org/x/text/transform vendor/golang.org/x/crypto/chacha20poly1305 +vendor/golang.org/x/text/transform vendor/golang.org/x/text/unicode/bidi vendor/golang.org/x/text/unicode/norm -crypto/ecdh -crypto/elliptic vendor/golang.org/x/text/secure/bidirule -crypto/ecdsa net/textproto +vendor/golang.org/x/net/idna vendor/golang.org/x/net/http2/hpack -crypto/x509 mime -vendor/golang.org/x/net/idna -mime/quotedprintable -mime/multipart +google.golang.org/protobuf/internal/filetype +crypto/tls vendor/golang.org/x/net/http/httpguts vendor/golang.org/x/net/http/httpproxy +google.golang.org/protobuf/runtime/protoimpl +blitiri.com.ar/go/chasquid/internal/config +mime/quotedprintable net/http/internal net/http/internal/ascii +mime/multipart blitiri.com.ar/go/chasquid/internal/envelope golang.org/x/text/transform golang.org/x/text/unicode/bidi golang.org/x/text/unicode/norm -crypto/tls -golang.org/x/text/secure/bidirule golang.org/x/text/internal/tag golang.org/x/text/internal/language -golang.org/x/net/idna -golang.org/x/text/internal/language/compact -golang.org/x/text/language +golang.org/x/text/secure/bidirule golang.org/x/text/runes -golang.org/x/text/internal golang.org/x/text/width -golang.org/x/text/cases os/exec -golang.org/x/text/secure/precis +golang.org/x/net/idna +golang.org/x/text/internal/language/compact +golang.org/x/text/language blitiri.com.ar/go/chasquid/internal/dovecot blitiri.com.ar/go/chasquid/internal/haproxy net/mail blitiri.com.ar/go/chasquid/internal/tlsconst +golang.org/x/text/internal golang.org/x/crypto/pbkdf2 +golang.org/x/text/cases golang.org/x/crypto/scrypt blitiri.com.ar/go/spf -net/http/httptrace -blitiri.com.ar/go/chasquid/internal/normalize -net/smtp -net/http -blitiri.com.ar/go/chasquid/internal/userdb -blitiri.com.ar/go/chasquid/internal/smtp blitiri.com.ar/go/systemd internal/lazyregexp internal/profile text/tabwriter runtime/pprof +net/http/httptrace +golang.org/x/text/secure/precis +net/http +net/smtp runtime/trace +blitiri.com.ar/go/chasquid/internal/normalize +blitiri.com.ar/go/chasquid/internal/userdb os/signal +blitiri.com.ar/go/chasquid/internal/smtp runtime/debug golang.org/x/sys/unix blitiri.com.ar/go/chasquid/cmd/mda-lmtp @@ -612,26 +648,26 @@ blitiri.com.ar/go/chasquid/internal/testlib golang.org/x/term expvar -golang.org/x/net/context/ctxhttp blitiri.com.ar/go/chasquid/internal/nettrace +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/localrpc -blitiri.com.ar/go/chasquid/internal/sts 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/courier blitiri.com.ar/go/chasquid/internal/auth blitiri.com.ar/go/chasquid/cmd/chasquid-util +blitiri.com.ar/go/chasquid/internal/courier blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/queue blitiri.com.ar/go/chasquid/internal/smtpsrv blitiri.com.ar/go/chasquid make[1]: Leaving directory '/build/reproducible-path/chasquid-1.13' dh_auto_test -O--buildsystem=golang - cd obj-arm-linux-gnueabihf && go test -vet=off -v -p 3 blitiri.com.ar/go/chasquid blitiri.com.ar/go/chasquid/cmd/chasquid-util blitiri.com.ar/go/chasquid/cmd/mda-lmtp blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/aliases blitiri.com.ar/go/chasquid/internal/auth blitiri.com.ar/go/chasquid/internal/config blitiri.com.ar/go/chasquid/internal/courier blitiri.com.ar/go/chasquid/internal/domaininfo blitiri.com.ar/go/chasquid/internal/dovecot blitiri.com.ar/go/chasquid/internal/envelope blitiri.com.ar/go/chasquid/internal/expvarom blitiri.com.ar/go/chasquid/internal/haproxy blitiri.com.ar/go/chasquid/internal/localrpc blitiri.com.ar/go/chasquid/internal/maillog blitiri.com.ar/go/chasquid/internal/nettrace blitiri.com.ar/go/chasquid/internal/normalize blitiri.com.ar/go/chasquid/internal/protoio blitiri.com.ar/go/chasquid/internal/protoio/testpb blitiri.com.ar/go/chasquid/internal/queue blitiri.com.ar/go/chasquid/internal/safeio blitiri.com.ar/go/chasquid/internal/set blitiri.com.ar/go/chasquid/internal/smtp blitiri.com.ar/go/chasquid/internal/smtpsrv blitiri.com.ar/go/chasquid/internal/sts blitiri.com.ar/go/chasquid/internal/testlib blitiri.com.ar/go/chasquid/internal/tlsconst blitiri.com.ar/go/chasquid/internal/trace blitiri.com.ar/go/chasquid/internal/userdb + cd obj-arm-linux-gnueabihf && go test -vet=off -v -p 4 blitiri.com.ar/go/chasquid blitiri.com.ar/go/chasquid/cmd/chasquid-util blitiri.com.ar/go/chasquid/cmd/mda-lmtp blitiri.com.ar/go/chasquid/cmd/smtp-check blitiri.com.ar/go/chasquid/internal/aliases blitiri.com.ar/go/chasquid/internal/auth blitiri.com.ar/go/chasquid/internal/config blitiri.com.ar/go/chasquid/internal/courier blitiri.com.ar/go/chasquid/internal/domaininfo blitiri.com.ar/go/chasquid/internal/dovecot blitiri.com.ar/go/chasquid/internal/envelope blitiri.com.ar/go/chasquid/internal/expvarom blitiri.com.ar/go/chasquid/internal/haproxy blitiri.com.ar/go/chasquid/internal/localrpc blitiri.com.ar/go/chasquid/internal/maillog blitiri.com.ar/go/chasquid/internal/nettrace blitiri.com.ar/go/chasquid/internal/normalize blitiri.com.ar/go/chasquid/internal/protoio blitiri.com.ar/go/chasquid/internal/protoio/testpb blitiri.com.ar/go/chasquid/internal/queue blitiri.com.ar/go/chasquid/internal/safeio blitiri.com.ar/go/chasquid/internal/set blitiri.com.ar/go/chasquid/internal/smtp blitiri.com.ar/go/chasquid/internal/smtpsrv blitiri.com.ar/go/chasquid/internal/sts blitiri.com.ar/go/chasquid/internal/testlib blitiri.com.ar/go/chasquid/internal/tlsconst blitiri.com.ar/go/chasquid/internal/trace blitiri.com.ar/go/chasquid/internal/userdb ? blitiri.com.ar/go/chasquid [no test files] ? blitiri.com.ar/go/chasquid/cmd/chasquid-util [no test files] ? blitiri.com.ar/go/chasquid/cmd/mda-lmtp [no test files] @@ -643,7 +679,7 @@ === RUN TestUserLookupErrors --- PASS: TestUserLookupErrors (0.00s) === RUN TestAddrRewrite ---- PASS: TestAddrRewrite (0.00s) +--- PASS: TestAddrRewrite (0.01s) === RUN TestExists --- PASS: TestExists (0.00s) === RUN TestRemoveDropsAndSuffix @@ -657,15 +693,15 @@ === RUN TestAddFile --- PASS: TestAddFile (0.01s) === RUN TestRichFile ---- PASS: TestRichFile (0.00s) +--- PASS: TestRichFile (0.01s) === RUN TestManyFiles ---- PASS: TestManyFiles (0.01s) +--- PASS: TestManyFiles (0.00s) === RUN TestHookError _ aliases.go:547 Hook.Alias-Resolve a@localA: error: exit status 1 _ aliases.go:547 Hook.Alias-Resolve a@localA: error: exit status 1 _ aliases.go:547 Hook.Alias-Resolve *@localA: error: exit status 1 _ aliases.go:547 Hook.Alias-Resolve a@localA: error: exit status 1 ---- PASS: TestHookError (0.04s) +--- PASS: TestHookError (0.02s) === RUN FuzzReader === RUN FuzzReader/seed#0 === RUN FuzzReader/1c24d2215db69748c6fd16797673ad11ebc7e6167fe1bc1f54c6959ec10407b6 @@ -673,7 +709,7 @@ === RUN FuzzReader/8234d8c5719f30e50525290db70743bf97d940e60591cf4a638c72158d35504a === RUN FuzzReader/c9c80ba9f513841cb081fe9bb7439d36f9f7a06bb999d4c39441991ccc878a9e === RUN FuzzReader/d40a98862ed393eb712e47a91bcef18e6f24cf368bb4bd248c7a7101ef8e178d ---- PASS: FuzzReader (0.01s) +--- PASS: FuzzReader (0.00s) --- PASS: FuzzReader/seed#0 (0.00s) --- PASS: FuzzReader/1c24d2215db69748c6fd16797673ad11ebc7e6167fe1bc1f54c6959ec10407b6 (0.00s) --- PASS: FuzzReader/4adaceaa32e2b32c00322948769d62c2dd42e1d9f4950d3c5b411c710e6d4a86 (0.00s) @@ -681,7 +717,7 @@ --- PASS: FuzzReader/c9c80ba9f513841cb081fe9bb7439d36f9f7a06bb999d4c39441991ccc878a9e (0.00s) --- PASS: FuzzReader/d40a98862ed393eb712e47a91bcef18e6f24cf368bb4bd248c7a7101ef8e178d (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/aliases 0.091s +ok blitiri.com.ar/go/chasquid/internal/aliases 0.084s === 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 @@ -694,11 +730,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 (2.01s) +--- PASS: TestAuthenticate (0.67s) === RUN TestInterfaces --- PASS: TestInterfaces (0.00s) === RUN TestMultipleBackends ---- PASS: TestMultipleBackends (0.20s) +--- PASS: TestMultipleBackends (0.19s) === RUN TestErrors --- PASS: TestErrors (0.00s) === RUN TestReload @@ -715,7 +751,7 @@ === RUN FuzzDecodeResponse/c2ae184876dd0fe9acfc8a5e2f2174a968b889b01e0f5c9a61fa27d7361f0091 === RUN FuzzDecodeResponse/d9aa9c617d1f5b3021aca758b9d896d136e3b16ed53233d02abffd02aa73ffa4 === RUN FuzzDecodeResponse/de05c7993312bab83e8114e9d9ced331c49822dc55c1a353f1cc9718a28226e7 ---- PASS: FuzzDecodeResponse (0.05s) +--- PASS: FuzzDecodeResponse (0.00s) --- PASS: FuzzDecodeResponse/0274b170c6fe2654ca5418a914b804e9c7cc5d8e5c2a7c5fcf5c29540ec5ae52 (0.00s) --- PASS: FuzzDecodeResponse/24d35771ef1fe0645d90b061e13a777faea328736483ec2833b63950d26b5399 (0.00s) --- PASS: FuzzDecodeResponse/2e5d0b26626f2d2dd6fb423e1e1cc432277ae9877c622fe6ca067e247bc11c9d (0.00s) @@ -727,27 +763,27 @@ --- PASS: FuzzDecodeResponse/d9aa9c617d1f5b3021aca758b9d896d136e3b16ed53233d02abffd02aa73ffa4 (0.00s) --- PASS: FuzzDecodeResponse/de05c7993312bab83e8114e9d9ced331c49822dc55c1a353f1cc9718a28226e7 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/auth 2.345s +ok blitiri.com.ar/go/chasquid/internal/auth 0.885s === RUN TestEmptyStruct ---- PASS: TestEmptyStruct (0.01s) +--- PASS: TestEmptyStruct (0.00s) === RUN TestEmptyConfig - testlib.go:32: test directory: "/tmp/testlib_1140148310" + testlib.go:32: test directory: "/tmp/testlib_2184587015" --- PASS: TestEmptyConfig (0.00s) === RUN TestFullConfig - testlib.go:32: test directory: "/tmp/testlib_1338223412" + testlib.go:32: test directory: "/tmp/testlib_577763507" --- PASS: TestFullConfig (0.00s) === RUN TestErrorLoading --- PASS: TestErrorLoading (0.00s) === RUN TestBrokenConfig - testlib.go:32: test directory: "/tmp/testlib_1285815062" + testlib.go:32: test directory: "/tmp/testlib_2153876615" --- PASS: TestBrokenConfig (0.00s) === RUN TestBrokenOverride - testlib.go:32: test directory: "/tmp/testlib_2481159740" + testlib.go:32: test directory: "/tmp/testlib_587072136" --- PASS: TestBrokenOverride (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/config 0.056s +ok blitiri.com.ar/go/chasquid/internal/config 0.039s === RUN TestMDA - testlib.go:32: test directory: "/tmp/testlib_114316992" + testlib.go:32: test directory: "/tmp/testlib_281615004" --- PASS: TestMDA (0.01s) === RUN TestMDATimeout _ mda.go:73 Courier.MDA to@local: error: operation timed out @@ -755,17 +791,17 @@ === RUN TestMDABadCommandLine _ mda.go:86 Courier.MDA to: error: MDA delivery failed: exec: \"thisdoesnotexist\": executable file not found in $PATH - \"\" _ mda.go:86 Courier.MDA to: error: MDA delivery failed: exit status 1 - \"cat: unrecognized option '--fail_unknown_option'\\nTry 'cat --help' for more information.\\n\" ---- PASS: TestMDABadCommandLine (0.01s) +--- PASS: TestMDABadCommandLine (0.00s) === 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_909939864" - testlib.go:32: test directory: "/tmp/testlib_3842554338" -_ smtp.go:127 Courier.SMTP to@to: error: Could not dial: dial tcp: address ::::45523: too many colons in address -_ smtp.go:101 Courier.SMTP to@to: error: \":::\" returned transient error: Could not dial: dial tcp: address ::::45523: too many colons in address + testlib.go:32: test directory: "/tmp/testlib_273354583" + testlib.go:32: test directory: "/tmp/testlib_1631468569" +_ smtp.go:127 Courier.SMTP to@to: error: Could not dial: dial tcp: address ::::43173: too many colons in address +_ smtp.go:101 Courier.SMTP to@to: error: \":::\" returned transient error: Could not dial: dial tcp: address ::::43173: 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:" @@ -773,26 +809,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.56s) +--- PASS: TestSMTP (0.21s) === RUN TestSMTPErrors - testlib.go:32: test directory: "/tmp/testlib_1229153350" - testlib.go:32: test directory: "/tmp/testlib_3318978920" + testlib.go:32: test directory: "/tmp/testlib_2797391319" + testlib.go:32: test directory: "/tmp/testlib_3219713795" fakeserver_test.go:98: fakeServer got connection -_ smtp.go:138 Courier.SMTP to@to: error: Error saying hello: write tcp 127.0.0.1:45178->127.0.0.1:45591: 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:45178->127.0.0.1:45591: 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:45178->127.0.0.1:45591: 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:45178->127.0.0.1:45591: i/o timeout) +_ smtp.go:138 Courier.SMTP to@to: error: Error saying hello: write tcp 127.0.0.1:58860->127.0.0.1:44175: 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:58860->127.0.0.1:44175: 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:58860->127.0.0.1:44175: 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:58860->127.0.0.1:44175: i/o timeout) fakeserver_test.go:105: fakeServer exiting: EOF - testlib.go:32: test directory: "/tmp/testlib_2458128984" - testlib.go:32: test directory: "/tmp/testlib_1334478132" + testlib.go:32: test directory: "/tmp/testlib_629854268" + testlib.go:32: test directory: "/tmp/testlib_33321539" 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_3730939379" - testlib.go:32: test directory: "/tmp/testlib_1659481216" + testlib.go:32: test directory: "/tmp/testlib_1924214045" + testlib.go:32: test directory: "/tmp/testlib_76121072" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -800,8 +836,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_365081834" - testlib.go:32: test directory: "/tmp/testlib_3163153844" + testlib.go:32: test directory: "/tmp/testlib_4130428461" + testlib.go:32: test directory: "/tmp/testlib_4050671170" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -810,8 +846,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_2408030887" - testlib.go:32: test directory: "/tmp/testlib_833789101" + testlib.go:32: test directory: "/tmp/testlib_2534756169" + testlib.go:32: test directory: "/tmp/testlib_1272279770" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" @@ -820,9 +856,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 (5.01s) +--- PASS: TestSMTPErrors (2.69s) === RUN TestNoMXServer - testlib.go:32: test directory: "/tmp/testlib_2763863275" + testlib.go:32: test directory: "/tmp/testlib_1866281389" _ 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) @@ -837,8 +873,8 @@ === RUN TestLookupInvalidDomain --- PASS: TestLookupInvalidDomain (0.00s) === RUN TestTLS - testlib.go:32: test directory: "/tmp/testlib_2476242697" - testlib.go:32: test directory: "/tmp/testlib_1757648652" + testlib.go:32: test directory: "/tmp/testlib_3583870362" + testlib.go:32: test directory: "/tmp/testlib_2121053835" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -849,7 +885,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_124548727" + testlib.go:32: test directory: "/tmp/testlib_2724714353" 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 @@ -857,26 +893,26 @@ _ 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.96s) +--- PASS: TestTLS (0.45s) === RUN TestTLSError - testlib.go:32: test directory: "/tmp/testlib_741309056" - testlib.go:32: test directory: "/tmp/testlib_473632104" + testlib.go:32: test directory: "/tmp/testlib_102018108" + testlib.go:32: test directory: "/tmp/testlib_4290973749" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" _ smtp.go:171 Courier.SMTP to@to: error: TLS error, retrying without TLS: 500 starttls err - fakeserver_test.go:105: fakeServer exiting: EOF fakeserver_test.go:98: fakeServer got connection + fakeserver_test.go:105: fakeServer exiting: EOF fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "MAIL FROM:" fakeserver_test.go:109: fakeServer read: "RCPT TO:" fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestTLSError (0.89s) +--- PASS: TestTLSError (0.21s) === RUN TestSTSPolicyEnforcement - testlib.go:32: test directory: "/tmp/testlib_1680930121" - testlib.go:32: test directory: "/tmp/testlib_245601998" + testlib.go:32: test directory: "/tmp/testlib_3236067790" + testlib.go:32: test directory: "/tmp/testlib_4206608145" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -884,7 +920,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_489713371" + testlib.go:32: test directory: "/tmp/testlib_1848173958" fakeserver_test.go:98: fakeServer got connection fakeserver_test.go:109: fakeServer read: "EHLO hello" fakeserver_test.go:109: fakeServer read: "STARTTLS" @@ -895,27 +931,27 @@ fakeserver_test.go:109: fakeServer read: "DATA" fakeserver_test.go:109: fakeServer read: "QUIT" fakeserver_test.go:105: fakeServer exiting: EOF ---- PASS: TestSTSPolicyEnforcement (1.05s) +--- PASS: TestSTSPolicyEnforcement (0.38s) PASS -ok blitiri.com.ar/go/chasquid/internal/courier 8.628s +ok blitiri.com.ar/go/chasquid/internal/courier 4.079s === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_2448453375" + testlib.go:32: test directory: "/tmp/testlib_76472651" _ domaininfo.go:117 DomainInfo.Incoming d1: d1 incoming level raised: TLS_SECURE > PLAIN _ domaininfo.go:109 DomainInfo.Incoming d1: error: d1 incoming denied: TLS_INSECURE < TLS_SECURE _ domaininfo.go:153 DomainInfo.Outgoing d1: d1 outgoing level raised: TLS_SECURE > PLAIN _ domaininfo.go:145 DomainInfo.Outgoing d1: error: d1 outgoing denied: TLS_INSECURE < TLS_SECURE _ domaininfo.go:109 DomainInfo.Incoming d1: error: d1 incoming denied: TLS_INSECURE < TLS_SECURE _ domaininfo.go:182 DomainInfo.SetToPlain d1: set to plain ---- PASS: TestBasic (0.03s) +--- PASS: TestBasic (0.00s) === RUN TestNewDomain - testlib.go:32: test directory: "/tmp/testlib_2483625565" + testlib.go:32: test directory: "/tmp/testlib_1646485611" _ 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.01s) +--- PASS: TestNewDomain (0.00s) === RUN TestProgressions - testlib.go:32: test directory: "/tmp/testlib_3527674733" + testlib.go:32: test directory: "/tmp/testlib_3859718855" _ 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 @@ -928,29 +964,29 @@ _ domaininfo.go:145 DomainInfo.Outgoing ssip: error: ssip outgoing denied: TLS_INSECURE < TLS_SECURE _ domaininfo.go:109 DomainInfo.Incoming ssip: error: ssip incoming denied: PLAIN < TLS_SECURE _ domaininfo.go:145 DomainInfo.Outgoing ssip: error: ssip outgoing denied: PLAIN < TLS_SECURE ---- PASS: TestProgressions (0.03s) +--- PASS: TestProgressions (0.01s) === RUN TestErrors - testlib.go:32: test directory: "/tmp/testlib_3315517389" + testlib.go:32: test directory: "/tmp/testlib_2659269796" _ 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.02s) +--- PASS: TestErrors (0.00s) === RUN TestDirectoryErrors - testlib.go:32: test directory: "/tmp/testlib_190976454" -_ domaininfo.go:59 DomainInfo.Reload reload: error: open /tmp/testlib_190976454/db: no such file or directory -_ domaininfo.go:84 DomainInfo.write d1: error: open /tmp/testlib_190976454/db/.s:d13663529900: no such file or directory + testlib.go:32: test directory: "/tmp/testlib_131688404" +_ domaininfo.go:59 DomainInfo.Reload reload: error: open /tmp/testlib_131688404/db: no such file or directory +_ domaininfo.go:84 DomainInfo.write d1: error: open /tmp/testlib_131688404/db/.s:d11946063635: no such file or directory --- PASS: TestDirectoryErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/domaininfo 0.108s +ok blitiri.com.ar/go/chasquid/internal/domaininfo 0.047s === RUN TestUsernameNotSafe --- PASS: TestUsernameNotSafe (0.00s) === RUN TestAutodetect - testlib.go:32: test directory: "/tmp/testlib_3357982096" + testlib.go:32: test directory: "/tmp/testlib_1067053070" --- PASS: TestAutodetect (0.00s) === RUN TestReload --- PASS: TestReload (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/dovecot 0.020s +ok blitiri.com.ar/go/chasquid/internal/dovecot 0.012s === RUN TestSplit --- PASS: TestSplit (0.00s) === RUN TestDomainIn @@ -958,13 +994,13 @@ === RUN TestAddHeader --- PASS: TestAddHeader (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/envelope 0.014s +ok blitiri.com.ar/go/chasquid/internal/envelope 0.010s === RUN TestHandler --- PASS: TestHandler (0.00s) === RUN TestMapLabelAccident --- PASS: TestMapLabelAccident (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/expvarom 0.051s +ok blitiri.com.ar/go/chasquid/internal/expvarom 0.029s === RUN TestNoNewline --- PASS: TestNoNewline (0.00s) === RUN TestBasic @@ -989,21 +1025,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.038s +ok blitiri.com.ar/go/chasquid/internal/haproxy 0.009s === RUN TestBadServer - asm_arm.s:859: FakeServer &{{0x28960f0}}: accepted - asm_arm.s:859: FakeServer &{{0x28960f0}}: readRequest: "" "" / EOF - asm_arm.s:859: FakeServer &{{0x28960f0}}: writeMessage("xxx"): 0 write unix /tmp/rpc-test-346857498/rpc.sock->@: write: broken pipe - asm_arm.s:859: FakeServer &{{0x28960f0}}: closing - asm_arm.s:859: FakeServer &{{0x2896190}}: accepted - asm_arm.s:859: FakeServer &{{0x2896190}}: readRequest: "Echo" "" / - asm_arm.s:859: FakeServer &{{0x2896190}}: writeMessage("xxx"): 3 - asm_arm.s:859: FakeServer &{{0x2896190}}: closing + asm_arm.s:859: FakeServer &{{0x218e0f0}}: accepted + asm_arm.s:859: FakeServer &{{0x218e0f0}}: readRequest: "" "" / EOF + asm_arm.s:859: FakeServer &{{0x218e0f0}}: writeMessage("xxx"): 0 write unix /tmp/rpc-test-1355067195/rpc.sock->@: write: broken pipe + asm_arm.s:859: FakeServer &{{0x218e0f0}}: closing + asm_arm.s:859: FakeServer &{{0x218e190}}: accepted + asm_arm.s:859: FakeServer &{{0x218e190}}: readRequest: "Echo" "" / + asm_arm.s:859: FakeServer &{{0x218e190}}: writeMessage("xxx"): 3 + asm_arm.s:859: FakeServer &{{0x218e190}}: closing --- PASS: TestBadServer (0.01s) === RUN TestBadSocket --- PASS: TestBadSocket (0.00s) === RUN TestEndToEnd -_ localrpc.go:63 LocalRPC.Server /tmp/rpc-test-3042243106/sock: Listening +_ localrpc.go:63 LocalRPC.Server /tmp/rpc-test-2333203783/sock: Listening === RUN TestEndToEnd/Echo === RUN TestEndToEnd/Echo#01 === RUN TestEndToEnd/Hola @@ -1011,8 +1047,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-3042243106/sock: error: Accept error: accept unix /tmp/rpc-test-3042243106/sock: use of closed network connection ---- PASS: TestEndToEnd (0.02s) +_ localrpc.go:67 LocalRPC.Server /tmp/rpc-test-2333203783/sock: error: Accept error: accept unix /tmp/rpc-test-2333203783/sock: use of closed network connection +--- PASS: TestEndToEnd (0.01s) --- PASS: TestEndToEnd/Echo (0.00s) --- PASS: TestEndToEnd/Echo#01 (0.00s) --- PASS: TestEndToEnd/Hola (0.00s) @@ -1026,7 +1062,7 @@ === RUN TestShortReadRequest --- PASS: TestShortReadRequest (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/localrpc 0.059s +ok blitiri.com.ar/go/chasquid/internal/localrpc 0.048s === RUN TestLogger --- PASS: TestLogger (0.00s) === RUN TestDefault @@ -1034,7 +1070,7 @@ === RUN TestFailedLogger --- PASS: TestFailedLogger (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/maillog 0.025s +ok blitiri.com.ar/go/chasquid/internal/maillog 0.017s === RUN TestContext --- PASS: TestContext (0.00s) === RUN TestHistogramBasic @@ -1042,19 +1078,19 @@ === RUN TestHistogramEmpty --- PASS: TestHistogramEmpty (0.00s) === RUN TestHTTP ---- PASS: TestHTTP (0.05s) +--- PASS: TestHTTP (0.03s) === RUN TestHTTPLong ---- PASS: TestHTTPLong (0.02s) +--- PASS: TestHTTPLong (0.01s) === RUN TestHTTPErrors ---- PASS: TestHTTPErrors (0.07s) +--- PASS: TestHTTPErrors (0.04s) === RUN TestHTTPUroboro --- PASS: TestHTTPUroboro (0.05s) === RUN TestHTTPDeep ---- PASS: TestHTTPDeep (0.03s) +--- PASS: TestHTTPDeep (0.02s) === RUN TestStripZeros --- PASS: TestStripZeros (0.00s) === RUN TestRegisterHandler ---- PASS: TestRegisterHandler (0.01s) +--- PASS: TestRegisterHandler (0.00s) === RUN TestBasic --- PASS: TestBasic (0.00s) === RUN TestLong @@ -1070,7 +1106,7 @@ === RUN TestFindParent --- PASS: TestFindParent (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/nettrace 0.259s +ok blitiri.com.ar/go/chasquid/internal/nettrace 0.167s === RUN TestUser --- PASS: TestUser (0.00s) === RUN TestDomain @@ -1087,7 +1123,7 @@ === RUN FuzzUser/6d603c8b9fbe8b9aa021dbde499ec1b3a00922b9338c68b2984cd314c3d5e633 === RUN FuzzUser/ccde73fe7b7352806a87cece8eb81867bdeb177019b69a4bb3c7bb5a277b9c32 === RUN FuzzUser/dc0204d8e2ab058a763873d2a5fede806e95235771ecdd96b56c906886822c19 ---- PASS: FuzzUser (0.02s) +--- PASS: FuzzUser (0.00s) --- PASS: FuzzUser/263da65bb5a59369f294d26a64a36a989a9a36ed5c60950b123e395bedbe881c (0.00s) --- PASS: FuzzUser/31400a53be6363c91bf6585789663189fa30b16181c1d18f19708acccc85f4a1 (0.00s) --- PASS: FuzzUser/6d603c8b9fbe8b9aa021dbde499ec1b3a00922b9338c68b2984cd314c3d5e633 (0.00s) @@ -1099,7 +1135,7 @@ === RUN FuzzDomain/6d603c8b9fbe8b9aa021dbde499ec1b3a00922b9338c68b2984cd314c3d5e633 === RUN FuzzDomain/ccde73fe7b7352806a87cece8eb81867bdeb177019b69a4bb3c7bb5a277b9c32 === RUN FuzzDomain/dc0204d8e2ab058a763873d2a5fede806e95235771ecdd96b56c906886822c19 ---- PASS: FuzzDomain (0.01s) +--- PASS: FuzzDomain (0.00s) --- PASS: FuzzDomain/263da65bb5a59369f294d26a64a36a989a9a36ed5c60950b123e395bedbe881c (0.00s) --- PASS: FuzzDomain/31400a53be6363c91bf6585789663189fa30b16181c1d18f19708acccc85f4a1 (0.00s) --- PASS: FuzzDomain/6d603c8b9fbe8b9aa021dbde499ec1b3a00922b9338c68b2984cd314c3d5e633 (0.00s) @@ -1111,7 +1147,7 @@ === RUN FuzzAddr/ccde73fe7b7352806a87cece8eb81867bdeb177019b69a4bb3c7bb5a277b9c32 === RUN FuzzAddr/d8637022b61fb5c4df4e153063564accd6331debaafdd594405c320a5e9f2e70 === RUN FuzzAddr/dc0204d8e2ab058a763873d2a5fede806e95235771ecdd96b56c906886822c19 ---- PASS: FuzzAddr (0.03s) +--- PASS: FuzzAddr (0.00s) --- PASS: FuzzAddr/31400a53be6363c91bf6585789663189fa30b16181c1d18f19708acccc85f4a1 (0.00s) --- PASS: FuzzAddr/7aba1e0ef80990ccac3731800dbb0267c4c8b7156d4da3b8a5f1b57a570adfb8 (0.00s) --- PASS: FuzzAddr/ccde73fe7b7352806a87cece8eb81867bdeb177019b69a4bb3c7bb5a277b9c32 (0.00s) @@ -1123,48 +1159,48 @@ === RUN FuzzDomainToUnicode/ccde73fe7b7352806a87cece8eb81867bdeb177019b69a4bb3c7bb5a277b9c32 === RUN FuzzDomainToUnicode/d8637022b61fb5c4df4e153063564accd6331debaafdd594405c320a5e9f2e70 === RUN FuzzDomainToUnicode/dc0204d8e2ab058a763873d2a5fede806e95235771ecdd96b56c906886822c19 ---- PASS: FuzzDomainToUnicode (0.02s) +--- PASS: FuzzDomainToUnicode (0.00s) --- PASS: FuzzDomainToUnicode/31400a53be6363c91bf6585789663189fa30b16181c1d18f19708acccc85f4a1 (0.00s) --- PASS: FuzzDomainToUnicode/7aba1e0ef80990ccac3731800dbb0267c4c8b7156d4da3b8a5f1b57a570adfb8 (0.00s) --- PASS: FuzzDomainToUnicode/ccde73fe7b7352806a87cece8eb81867bdeb177019b69a4bb3c7bb5a277b9c32 (0.00s) --- PASS: FuzzDomainToUnicode/d8637022b61fb5c4df4e153063564accd6331debaafdd594405c320a5e9f2e70 (0.00s) --- PASS: FuzzDomainToUnicode/dc0204d8e2ab058a763873d2a5fede806e95235771ecdd96b56c906886822c19 (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/normalize 0.100s +ok blitiri.com.ar/go/chasquid/internal/normalize 0.014s ? blitiri.com.ar/go/chasquid/internal/protoio/testpb [no test files] === RUN TestBin - testlib.go:32: test directory: "/tmp/testlib_2723119743" ---- PASS: TestBin (0.01s) + testlib.go:32: test directory: "/tmp/testlib_4279813955" +--- PASS: TestBin (0.00s) === RUN TestText - testlib.go:32: test directory: "/tmp/testlib_3879317898" + testlib.go:32: test directory: "/tmp/testlib_1667860778" --- PASS: TestText (0.00s) === RUN TestStore - testlib.go:32: test directory: "/tmp/testlib_1446559282" + testlib.go:32: test directory: "/tmp/testlib_930120436" --- PASS: TestStore (0.00s) === RUN TestFileErrors - testlib.go:32: test directory: "/tmp/testlib_2550871411" + testlib.go:32: test directory: "/tmp/testlib_38773600" --- PASS: TestFileErrors (0.00s) === RUN TestMarshalErrors - testlib.go:32: test directory: "/tmp/testlib_4191430719" + testlib.go:32: test directory: "/tmp/testlib_727922347" --- PASS: TestMarshalErrors (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/protoio 0.035s +ok blitiri.com.ar/go/chasquid/internal/protoio 0.018s === RUN TestDSN dsn_test.go:49: From: Mail Delivery System To: Subject: Mail delivery failed: returning message to sender - Message-ID: - Date: Thu, 18 Apr 2024 09:57:27 +0000 + Message-ID: + Date: Thu, 18 Apr 2024 10:01:56 +0000 In-Reply-To: References: X-Failed-Recipients: pepe@africa.org, ñaca@africa.org, Auto-Submitted: auto-replied MIME-Version: 1.0 Content-Type: multipart/report; report-type=delivery-status; - boundary="K2frA2_0IW0" + boundary="yxBOTtbnJYE" - --K2frA2_0IW0 + --yxBOTtbnJYE Content-Type: text/plain; charset="utf-8" Content-Disposition: inline Content-Description: Notification @@ -1189,7 +1225,7 @@ oh! the humanity! - --K2frA2_0IW0 + --yxBOTtbnJYE Content-Type: message/global-delivery-status Content-Description: Delivery Report Content-Transfer-Encoding: 8bit @@ -1220,7 +1256,7 @@ - --K2frA2_0IW0 + --yxBOTtbnJYE Content-Type: message/rfc822 Content-Description: Undelivered Message Content-Transfer-Encoding: 8bit @@ -1230,75 +1266,73 @@ Data ñaca. - --K2frA2_0IW0-- + --yxBOTtbnJYE-- --- PASS: TestDSN (0.00s) === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_3415411976" -_ queue.go:308 Queue.SendLoop yYLE81cktDU: from from -_ queue.go:367 Queue.SendLoop yYLE81cktDU: nodomain sent -_ queue.go:367 Queue.SendLoop yYLE81cktDU: am@loco sent -_ queue.go:367 Queue.SendLoop yYLE81cktDU: x@remote sent -_ queue.go:342 Queue.SendLoop yYLE81cktDU: all done ---- PASS: TestBasic (0.05s) + testlib.go:32: test directory: "/tmp/testlib_3517669710" +_ queue.go:308 Queue.SendLoop K2Ypjnq82LM: from from +_ queue.go:367 Queue.SendLoop K2Ypjnq82LM: nodomain sent +_ queue.go:367 Queue.SendLoop K2Ypjnq82LM: x@remote sent +_ queue.go:367 Queue.SendLoop K2Ypjnq82LM: am@loco sent +_ queue.go:342 Queue.SendLoop K2Ypjnq82LM: all done +--- PASS: TestBasic (0.02s) === RUN TestDSNOnTimeout - testlib.go:32: test directory: "/tmp/testlib_2536420396" -_ queue.go:308 Queue.SendLoop Qe5SJTvUdaw: from from@loco -_ queue.go:465 Queue.SendLoop Qe5SJTvUdaw: queued DSN: UA9gejhBiVs -_ queue.go:342 Queue.SendLoop Qe5SJTvUdaw: all done -_ queue.go:308 Queue.SendLoop UA9gejhBiVs: from <> -_ queue.go:367 Queue.SendLoop UA9gejhBiVs: from@loco sent -_ queue.go:342 Queue.SendLoop UA9gejhBiVs: all done ---- PASS: TestDSNOnTimeout (0.01s) + testlib.go:32: test directory: "/tmp/testlib_3711129634" +_ queue.go:308 Queue.SendLoop vSejRgXHwhE: from from@loco +_ queue.go:465 Queue.SendLoop vSejRgXHwhE: queued DSN: hhdZRcqnBBg +_ queue.go:342 Queue.SendLoop vSejRgXHwhE: all done +_ queue.go:308 Queue.SendLoop hhdZRcqnBBg: from <> +_ queue.go:367 Queue.SendLoop hhdZRcqnBBg: from@loco sent +_ queue.go:342 Queue.SendLoop hhdZRcqnBBg: all done +--- PASS: TestDSNOnTimeout (0.00s) === RUN TestAliases - testlib.go:32: test directory: "/tmp/testlib_2664713982" -_ queue.go:308 Queue.SendLoop _1P-PnjgfFM: from from -_ queue.go:367 Queue.SendLoop _1P-PnjgfFM: ata@hualpa sent -_ queue.go:367 Queue.SendLoop _1P-PnjgfFM: pq@loco sent ---- PASS: TestAliases (0.01s) + testlib.go:32: test directory: "/tmp/testlib_1930827946" +_ queue.go:308 Queue.SendLoop hDqgZBpm_gU: from from +_ queue.go:367 Queue.SendLoop hDqgZBpm_gU: ata@hualpa sent +_ queue.go:367 Queue.SendLoop hDqgZBpm_gU: pq@loco sent +_ queue.go:367 Queue.SendLoop hDqgZBpm_gU: rs@loco sent +_ queue.go:342 Queue.SendLoop hDqgZBpm_gU: all done +--- PASS: TestAliases (0.00s) === RUN TestFullQueue - testlib.go:32: test directory: "/tmp/testlib_1636041793" + testlib.go:32: test directory: "/tmp/testlib_397227869" _ queue.go:164 Queue.Put from: error: queue full -_ queue.go:367 Queue.SendLoop _1P-PnjgfFM: rs@loco sent -_ queue.go:375 Queue.SendLoop _1P-PnjgfFM: error: failed to write: open /tmp/testlib_2664713982/.m:_1P-PnjgfFM3373161378: no such file or directory -_ queue.go:375 Queue.SendLoop _1P-PnjgfFM: error: failed to write: open /tmp/testlib_2664713982/.m:_1P-PnjgfFM1901682527: no such file or directory -_ queue.go:342 Queue.SendLoop _1P-PnjgfFM: all done -E queue.go:230 failed to remove queue file "/tmp/testlib_2664713982/m:_1P-PnjgfFM": remove /tmp/testlib_2664713982/m:_1P-PnjgfFM: no such file or directory ---- PASS: TestFullQueue (0.01s) +--- PASS: TestFullQueue (0.00s) === RUN TestPipes - testlib.go:32: test directory: "/tmp/testlib_2543968994" -_ queue.go:308 Queue.SendLoop VvMS6ODF8jE: from from -_ queue.go:367 Queue.SendLoop VvMS6ODF8jE: to sent -_ queue.go:375 Queue.SendLoop VvMS6ODF8jE: error: failed to write: open /tmp/testlib_1636041793/.m:VvMS6ODF8jE4245926744: no such file or directory -_ queue.go:342 Queue.SendLoop VvMS6ODF8jE: all done -E queue.go:230 failed to remove queue file "/tmp/testlib_1636041793/m:VvMS6ODF8jE": remove /tmp/testlib_1636041793/m:VvMS6ODF8jE: no such file or directory + testlib.go:32: test directory: "/tmp/testlib_2726988783" +_ queue.go:308 Queue.SendLoop njPI3PMIDGw: from from +_ queue.go:367 Queue.SendLoop njPI3PMIDGw: to sent +_ queue.go:375 Queue.SendLoop njPI3PMIDGw: error: failed to write: open /tmp/testlib_397227869/.m:njPI3PMIDGw1799849567: no such file or directory +_ queue.go:342 Queue.SendLoop njPI3PMIDGw: all done +E queue.go:230 failed to remove queue file "/tmp/testlib_397227869/m:njPI3PMIDGw": remove /tmp/testlib_397227869/m:njPI3PMIDGw: no such file or directory --- PASS: TestPipes (0.01s) === RUN TestBadPath --- PASS: TestBadPath (0.00s) === RUN TestNextDelay --- PASS: TestNextDelay (0.00s) === RUN TestSerialization - testlib.go:32: test directory: "/tmp/testlib_505890238" -_ queue.go:308 Queue.SendLoop I5VooCkFxCk: from from@loco -_ queue.go:367 Queue.SendLoop I5VooCkFxCk: to@to sent ---- PASS: TestSerialization (0.01s) + testlib.go:32: test directory: "/tmp/testlib_2011919012" +_ queue.go:308 Queue.SendLoop vTXCZVqNCyA: from from@loco +_ queue.go:367 Queue.SendLoop vTXCZVqNCyA: to@to sent +_ queue.go:342 Queue.SendLoop vTXCZVqNCyA: all done +--- PASS: TestSerialization (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/queue 0.154s +ok blitiri.com.ar/go/chasquid/internal/queue 0.076s === RUN TestWriteFile - testlib.go:32: test directory: "/tmp/testlib_2244010007" + testlib.go:32: test directory: "/tmp/testlib_2573601661" --- PASS: TestWriteFile (0.01s) === RUN TestWriteFileWithOp - testlib.go:32: test directory: "/tmp/testlib_1238262449" + testlib.go:32: test directory: "/tmp/testlib_2082150034" --- PASS: TestWriteFileWithOp (0.00s) === RUN TestWriteFileWithFailingOp - testlib.go:32: test directory: "/tmp/testlib_1569925066" + testlib.go:32: test directory: "/tmp/testlib_3772584055" --- PASS: TestWriteFileWithFailingOp (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/safeio 0.023s +ok blitiri.com.ar/go/chasquid/internal/safeio 0.030s === RUN TestString --- PASS: TestString (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/set 0.014s +ok blitiri.com.ar/go/chasquid/internal/set 0.010s === RUN TestIsPermanent --- PASS: TestIsPermanent (0.00s) === RUN TestIsASCII @@ -1312,22 +1346,22 @@ === RUN TestFallbackToIDNA --- PASS: TestFallbackToIDNA (0.00s) === RUN TestLineTooLong ---- PASS: TestLineTooLong (0.09s) +--- PASS: TestLineTooLong (0.05s) PASS -ok blitiri.com.ar/go/chasquid/internal/smtp 0.116s +ok blitiri.com.ar/go/chasquid/internal/smtp 0.062s ? blitiri.com.ar/go/chasquid/internal/trace [no test files] -_ server.go:242 Server listening on 127.0.0.1:45679 (SMTP) -2024-04-18 09:57:33.893805 daemon listening on 127.0.0.1:45679 -_ server.go:242 Server listening on 127.0.0.1:42229 (submission) -2024-04-18 09:57:33.894186 daemon listening on 127.0.0.1:42229 -_ server.go:242 Server listening on 127.0.0.1:38691 (submission+TLS) -2024-04-18 09:57:33.894361 daemon listening on 127.0.0.1:38691 +_ server.go:242 Server listening on 127.0.0.1:43245 (SMTP) +2024-04-18 10:01:59.938200 daemon listening on 127.0.0.1:43245 +_ server.go:242 Server listening on 127.0.0.1:46345 (submission) +2024-04-18 10:01:59.938360 daemon listening on 127.0.0.1:46345 +_ server.go:242 Server listening on 127.0.0.1:41927 (submission+TLS) +2024-04-18 10:01:59.938429 daemon listening on 127.0.0.1:41927 === RUN TestSecLevel _ domaininfo.go:117 DomainInfo.Incoming slc: slc incoming level raised: TLS_CLIENT > PLAIN -_ conn.go:188 SMTP.Conn 127.0.0.1:48456: error: error completing TLS handshake: EOF _ domaininfo.go:109 DomainInfo.Incoming slc: error: slc incoming denied: PLAIN < TLS_CLIENT _ conn.go:538 testconn testconn: error: security level check for slc failed (PLAIN) ---- PASS: TestSecLevel (0.02s) +_ conn.go:188 SMTP.Conn 127.0.0.1:56262: error: error completing TLS handshake: EOF +--- PASS: TestSecLevel (0.01s) === RUN TestIsHeader --- PASS: TestIsHeader (0.00s) === RUN TestAddrLiteral @@ -1339,238 +1373,237 @@ === RUN TestReadUntilDotReadError --- PASS: TestReadUntilDotReadError (0.00s) === RUN TestSimple -_ conn.go:689 SMTP.Conn 127.0.0.1:34980: Queued from from@from to [to@localhost] - HzJdUzkMEPw -2024-04-18 09:57:34.024536 HzJdUzkMEPw from=from@from queued ip=127.0.0.1:34980 to=[to@localhost] -_ queue.go:308 Queue.SendLoop HzJdUzkMEPw: from from@from -_ queue.go:367 Queue.SendLoop HzJdUzkMEPw: testuser@localhost sent -2024-04-18 09:57:34.024914 HzJdUzkMEPw from=from@from to=testuser@localhost sent ---- PASS: TestSimple (0.01s) +_ conn.go:689 SMTP.Conn 127.0.0.1:50502: Queued from from@from to [to@localhost] - RUBeoT471gA +2024-04-18 10:02:00.053482 RUBeoT471gA from=from@from queued ip=127.0.0.1:50502 to=[to@localhost] +_ queue.go:308 Queue.SendLoop RUBeoT471gA: from from@from +_ queue.go:367 Queue.SendLoop RUBeoT471gA: testuser@localhost sent +2024-04-18 10:02:00.053782 RUBeoT471gA from=from@from to=testuser@localhost sent +--- PASS: TestSimple (0.00s) === RUN TestSimpleTLS -_ queue.go:342 Queue.SendLoop HzJdUzkMEPw: all done -2024-04-18 09:57:34.034807 HzJdUzkMEPw from=from@from all done -_ conn.go:689 SMTP.Conn 127.0.0.1:34986: Queued from from@from to [to@localhost] - -1p_NlAyAIw -2024-04-18 09:57:34.105960 -1p_NlAyAIw from=from@from queued ip=127.0.0.1:34986 to=[to@localhost] -_ queue.go:308 Queue.SendLoop -1p_NlAyAIw: from from@from -_ queue.go:367 Queue.SendLoop -1p_NlAyAIw: testuser@localhost sent -2024-04-18 09:57:34.106332 -1p_NlAyAIw from=from@from to=testuser@localhost sent ---- PASS: TestSimpleTLS (0.08s) +_ queue.go:342 Queue.SendLoop RUBeoT471gA: all done +2024-04-18 10:02:00.054401 RUBeoT471gA from=from@from all done +_ conn.go:689 SMTP.Conn 127.0.0.1:50518: Queued from from@from to [to@localhost] - AIsa2eYoXVQ +2024-04-18 10:02:00.087486 AIsa2eYoXVQ from=from@from queued ip=127.0.0.1:50518 to=[to@localhost] +_ queue.go:308 Queue.SendLoop AIsa2eYoXVQ: from from@from +_ queue.go:367 Queue.SendLoop AIsa2eYoXVQ: testuser@localhost sent +2024-04-18 10:02:00.087695 AIsa2eYoXVQ from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop AIsa2eYoXVQ: all done +2024-04-18 10:02:00.088214 AIsa2eYoXVQ from=from@from all done +--- PASS: TestSimpleTLS (0.03s) === RUN TestManyEmails -_ queue.go:342 Queue.SendLoop -1p_NlAyAIw: all done -2024-04-18 09:57:34.119115 -1p_NlAyAIw from=from@from all done -_ conn.go:689 SMTP.Conn 127.0.0.1:35002: Queued from from@from to [to@localhost] - GnsrUYbPGCU -2024-04-18 09:57:34.162656 GnsrUYbPGCU from=from@from queued ip=127.0.0.1:35002 to=[to@localhost] -_ queue.go:308 Queue.SendLoop GnsrUYbPGCU: from from@from -_ queue.go:367 Queue.SendLoop GnsrUYbPGCU: testuser@localhost sent -2024-04-18 09:57:34.162986 GnsrUYbPGCU from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop GnsrUYbPGCU: all done -2024-04-18 09:57:34.163713 GnsrUYbPGCU from=from@from all done -_ conn.go:689 SMTP.Conn 127.0.0.1:35002: Queued from from@from to [to@localhost] - PwAa6nAQXdQ -_ queue.go:308 Queue.SendLoop PwAa6nAQXdQ: from from@from -_ queue.go:367 Queue.SendLoop PwAa6nAQXdQ: testuser@localhost sent -2024-04-18 09:57:34.166861 PwAa6nAQXdQ from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop PwAa6nAQXdQ: all done -2024-04-18 09:57:34.167863 PwAa6nAQXdQ from=from@from all done -2024-04-18 09:57:34.166391 PwAa6nAQXdQ from=from@from queued ip=127.0.0.1:35002 to=[to@localhost] -_ conn.go:689 SMTP.Conn 127.0.0.1:35002: Queued from from@from to [to@localhost] - ifpA-MW9_VQ -2024-04-18 09:57:34.170852 ifpA-MW9_VQ from=from@from queued ip=127.0.0.1:35002 to=[to@localhost] -_ queue.go:308 Queue.SendLoop ifpA-MW9_VQ: from from@from -_ queue.go:367 Queue.SendLoop ifpA-MW9_VQ: testuser@localhost sent -2024-04-18 09:57:34.171163 ifpA-MW9_VQ from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop ifpA-MW9_VQ: all done -2024-04-18 09:57:34.172147 ifpA-MW9_VQ from=from@from all done ---- PASS: TestManyEmails (0.07s) +_ conn.go:689 SMTP.Conn 127.0.0.1:50530: Queued from from@from to [to@localhost] - 4so79SI-KuM +2024-04-18 10:02:00.103204 4so79SI-KuM from=from@from queued ip=127.0.0.1:50530 to=[to@localhost] +_ queue.go:308 Queue.SendLoop 4so79SI-KuM: from from@from +_ queue.go:367 Queue.SendLoop 4so79SI-KuM: testuser@localhost sent +2024-04-18 10:02:00.103466 4so79SI-KuM from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop 4so79SI-KuM: all done +2024-04-18 10:02:00.103988 4so79SI-KuM from=from@from all done +_ conn.go:689 SMTP.Conn 127.0.0.1:50530: Queued from from@from to [to@localhost] - 1wyJ7K1Zpfk +2024-04-18 10:02:00.108098 1wyJ7K1Zpfk from=from@from queued ip=127.0.0.1:50530 to=[to@localhost] +_ queue.go:308 Queue.SendLoop 1wyJ7K1Zpfk: from from@from +_ queue.go:367 Queue.SendLoop 1wyJ7K1Zpfk: testuser@localhost sent +2024-04-18 10:02:00.108296 1wyJ7K1Zpfk from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop 1wyJ7K1Zpfk: all done +2024-04-18 10:02:00.108883 1wyJ7K1Zpfk from=from@from all done +_ conn.go:689 SMTP.Conn 127.0.0.1:50530: Queued from from@from to [to@localhost] - MRdKvCizUBM +2024-04-18 10:02:00.113515 MRdKvCizUBM from=from@from queued ip=127.0.0.1:50530 to=[to@localhost] +_ queue.go:308 Queue.SendLoop MRdKvCizUBM: from from@from +_ queue.go:367 Queue.SendLoop MRdKvCizUBM: testuser@localhost sent +2024-04-18 10:02:00.113727 MRdKvCizUBM from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop MRdKvCizUBM: all done +2024-04-18 10:02:00.114257 MRdKvCizUBM from=from@from all done +--- PASS: TestManyEmails (0.03s) === RUN TestAuth -2024-04-18 09:57:34.487295 127.0.0.1:49092 auth succeeded for testuser@localhost -_ conn.go:689 SMTP.Conn 127.0.0.1:49092: Queued from testuser@localhost to [to@localhost] - j7O18xoVUck -2024-04-18 09:57:34.490216 j7O18xoVUck from=testuser@localhost queued ip=127.0.0.1:49092 to=[to@localhost] -_ queue.go:308 Queue.SendLoop j7O18xoVUck: from testuser@localhost -_ queue.go:367 Queue.SendLoop j7O18xoVUck: testuser@localhost sent -2024-04-18 09:57:34.490902 j7O18xoVUck from=testuser@localhost to=testuser@localhost sent ---- PASS: TestAuth (0.32s) +2024-04-18 10:02:00.254897 127.0.0.1:54036 auth succeeded for testuser@localhost +_ conn.go:689 SMTP.Conn 127.0.0.1:54036: Queued from testuser@localhost to [to@localhost] - aNR3DrZmwd8 +2024-04-18 10:02:00.256643 aNR3DrZmwd8 from=testuser@localhost queued ip=127.0.0.1:54036 to=[to@localhost] +_ queue.go:308 Queue.SendLoop aNR3DrZmwd8: from testuser@localhost +_ queue.go:367 Queue.SendLoop aNR3DrZmwd8: testuser@localhost sent +2024-04-18 10:02:00.256842 aNR3DrZmwd8 from=testuser@localhost to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop aNR3DrZmwd8: all done +2024-04-18 10:02:00.257327 aNR3DrZmwd8 from=testuser@localhost all done +--- PASS: TestAuth (0.14s) === RUN TestSubmissionWithoutAuth -_ queue.go:342 Queue.SendLoop j7O18xoVUck: all done -2024-04-18 09:57:34.498149 j7O18xoVUck from=testuser@localhost all done -_ conn.go:297 SMTP.Conn 127.0.0.1:49108: error: MAIL failed: 550 5.7.9 Mail to submission port must be authenticated ---- PASS: TestSubmissionWithoutAuth (0.04s) +_ conn.go:297 SMTP.Conn 127.0.0.1:54038: error: MAIL failed: 550 5.7.9 Mail to submission port must be authenticated +--- PASS: TestSubmissionWithoutAuth (0.02s) === RUN TestAuthOnTLS -2024-04-18 09:57:34.817468 127.0.0.1:48470 auth succeeded for testuser@localhost -_ conn.go:689 SMTP.Conn 127.0.0.1:48470: Queued from testuser@localhost to [to@localhost] - M6vrO72b78s -2024-04-18 09:57:34.821164 M6vrO72b78s from=testuser@localhost queued ip=127.0.0.1:48470 to=[to@localhost] -_ queue.go:308 Queue.SendLoop M6vrO72b78s: from testuser@localhost -_ queue.go:367 Queue.SendLoop M6vrO72b78s: testuser@localhost sent -2024-04-18 09:57:34.825901 M6vrO72b78s from=testuser@localhost to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop M6vrO72b78s: all done -2024-04-18 09:57:34.827384 M6vrO72b78s from=testuser@localhost all done ---- PASS: TestAuthOnTLS (0.30s) +2024-04-18 10:02:00.401891 127.0.0.1:56276 auth succeeded for testuser@localhost +_ conn.go:689 SMTP.Conn 127.0.0.1:56276: Queued from testuser@localhost to [to@localhost] - 9CKD4283c5k +2024-04-18 10:02:00.404091 9CKD4283c5k from=testuser@localhost queued ip=127.0.0.1:56276 to=[to@localhost] +_ queue.go:308 Queue.SendLoop 9CKD4283c5k: from testuser@localhost +_ queue.go:367 Queue.SendLoop 9CKD4283c5k: testuser@localhost sent +2024-04-18 10:02:00.406557 9CKD4283c5k from=testuser@localhost to=testuser@localhost sent +--- PASS: TestAuthOnTLS (0.13s) === RUN TestAuthOnSMTP -2024-04-18 09:57:35.119989 127.0.0.1:35004 auth succeeded for testuser@localhost -_ conn.go:689 SMTP.Conn 127.0.0.1:35004: Queued from testuser@localhost to [to@localhost] - BbYaGafU4IE -2024-04-18 09:57:35.122694 BbYaGafU4IE from=testuser@localhost queued ip=127.0.0.1:35004 to=[to@localhost] -_ queue.go:308 Queue.SendLoop BbYaGafU4IE: from testuser@localhost -_ queue.go:367 Queue.SendLoop BbYaGafU4IE: testuser@localhost sent -2024-04-18 09:57:35.123082 BbYaGafU4IE from=testuser@localhost to=testuser@localhost sent ---- PASS: TestAuthOnSMTP (0.30s) +_ queue.go:342 Queue.SendLoop 9CKD4283c5k: all done +2024-04-18 10:02:00.408102 9CKD4283c5k from=testuser@localhost all done +2024-04-18 10:02:00.551480 127.0.0.1:50536 auth succeeded for testuser@localhost +_ conn.go:689 SMTP.Conn 127.0.0.1:50536: Queued from testuser@localhost to [to@localhost] - _LEfakdjckc +2024-04-18 10:02:00.553211 _LEfakdjckc from=testuser@localhost queued ip=127.0.0.1:50536 to=[to@localhost] +_ queue.go:308 Queue.SendLoop _LEfakdjckc: from testuser@localhost +_ queue.go:367 Queue.SendLoop _LEfakdjckc: testuser@localhost sent +2024-04-18 10:02:00.553410 _LEfakdjckc from=testuser@localhost to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop _LEfakdjckc: all done +2024-04-18 10:02:00.553912 _LEfakdjckc from=testuser@localhost all done +--- PASS: TestAuthOnSMTP (0.15s) === RUN TestBrokenAuth -_ queue.go:342 Queue.SendLoop BbYaGafU4IE: all done -2024-04-18 09:57:35.126877 BbYaGafU4IE from=testuser@localhost all done -_ conn.go:1062 SMTP.Conn 127.0.0.1:49118: error: error authenticating \"user\"@\"broken\": failed to auth -2024-04-18 09:57:35.269664 127.0.0.1:49118 auth failed for user@broken -_ conn.go:297 SMTP.Conn 127.0.0.1:49118: error: AUTH failed: 454 4.7.0 Temporary authentication failure -_ conn.go:297 SMTP.Conn 127.0.0.1:49118: error: unknown<\"*\"> failed: 500 5.5.1 Unknown command ---- PASS: TestBrokenAuth (0.15s) +_ conn.go:1062 SMTP.Conn 127.0.0.1:49470: error: error authenticating \"user\"@\"broken\": failed to auth +2024-04-18 10:02:00.684602 127.0.0.1:49470 auth failed for user@broken +_ conn.go:297 SMTP.Conn 127.0.0.1:49470: error: AUTH failed: 454 4.7.0 Temporary authentication failure +_ conn.go:297 SMTP.Conn 127.0.0.1:49470: error: unknown<\"*\"> failed: 500 5.5.1 Unknown command +--- PASS: TestBrokenAuth (0.13s) === RUN TestWrongMailParsing -_ conn.go:297 SMTP.Conn 127.0.0.1:35012: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:35012: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:35012: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:35012: error: too many errors, breaking connection -_ conn.go:297 SMTP.Conn 127.0.0.1:35020: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:35020: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:35020: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:35020: error: too many errors, breaking connection -_ conn.go:297 SMTP.Conn 127.0.0.1:35036: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:35036: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:35036: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:35036: error: too many errors, breaking connection -_ conn.go:297 SMTP.Conn 127.0.0.1:35038: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:35038: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:35038: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:35038: error: too many errors, breaking connection -_ conn.go:297 SMTP.Conn 127.0.0.1:35046: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:35046: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:35046: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:35046: error: too many errors, breaking connection -_ conn.go:297 SMTP.Conn 127.0.0.1:35050: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:297 SMTP.Conn 127.0.0.1:35050: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:297 SMTP.Conn 127.0.0.1:35050: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:35050: error: too many errors, breaking connection ---- PASS: TestWrongMailParsing (0.02s) +_ conn.go:297 SMTP.Conn 127.0.0.1:58016: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:58016: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:58016: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:58016: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:58030: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:58030: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:58030: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:58030: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:58038: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:58038: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:58038: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:58038: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:58052: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:58052: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:58052: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:58052: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:58054: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:58054: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:58054: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:58054: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:58064: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:297 SMTP.Conn 127.0.0.1:58064: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:297 SMTP.Conn 127.0.0.1:58064: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:58064: error: too many errors, breaking connection +--- PASS: TestWrongMailParsing (0.01s) === RUN TestNullMailFrom --- PASS: TestNullMailFrom (0.00s) === RUN TestRcptBeforeMail -_ conn.go:297 SMTP.Conn 127.0.0.1:35058: error: RCPT failed: 503 5.5.1 Sender not yet given +_ conn.go:297 SMTP.Conn 127.0.0.1:58082: error: RCPT failed: 503 5.5.1 Sender not yet given --- PASS: TestRcptBeforeMail (0.00s) === RUN TestRcptOption ---- PASS: TestRcptOption (0.04s) +--- PASS: TestRcptOption (0.01s) === RUN TestRelayForbidden -2024-04-18 09:57:35.342954 127.0.0.1:35080 rejected from=from@somewhere to=[to@somewhere] - relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:35080: error: RCPT failed: 503 5.7.1 Relay not allowed +2024-04-18 10:02:00.714697 127.0.0.1:58092 rejected from=from@somewhere to=[to@somewhere] - relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:58092: error: RCPT failed: 503 5.7.1 Relay not allowed --- PASS: TestRelayForbidden (0.00s) === RUN TestTooManyRecipients -2024-04-18 09:57:35.617615 127.0.0.1:49120 auth succeeded for testuser@localhost -_ conn.go:297 SMTP.Conn 127.0.0.1:49120: error: RCPT failed: 452 4.5.3 Too many recipients ---- PASS: TestTooManyRecipients (0.31s) +2024-04-18 10:02:00.854188 127.0.0.1:49476 auth succeeded for testuser@localhost +_ conn.go:297 SMTP.Conn 127.0.0.1:49476: error: RCPT failed: 452 4.5.3 Too many recipients +--- PASS: TestTooManyRecipients (0.16s) === RUN TestRcptBrokenExists -_ conn.go:601 SMTP.Conn 127.0.0.1:35088: error: error checking if user \"to@broken\" exists: failed to check if user exists -2024-04-18 09:57:35.692159 127.0.0.1:35088 rejected from=from@localhost to=[to@broken] - error checking if user exists: failed to check if user exists -_ conn.go:297 SMTP.Conn 127.0.0.1:35088: error: RCPT failed: 451 4.4.3 Temporary error checking address ---- PASS: TestRcptBrokenExists (0.04s) +_ conn.go:601 SMTP.Conn 127.0.0.1:58102: error: error checking if user \"to@broken\" exists: failed to check if user exists +2024-04-18 10:02:00.895919 127.0.0.1:58102 rejected from=from@localhost to=[to@broken] - error checking if user exists: failed to check if user exists +_ conn.go:297 SMTP.Conn 127.0.0.1:58102: error: RCPT failed: 451 4.4.3 Temporary error checking address +--- PASS: TestRcptBrokenExists (0.02s) === RUN TestRcptUserDoesNotExist -2024-04-18 09:57:35.724395 127.0.0.1:35090 rejected from=from@localhost to=[doesnotexist@localhost] - local user does not exist -_ conn.go:297 SMTP.Conn 127.0.0.1:35090: error: RCPT failed: 550 5.1.1 Destination address is unknown (user does not exist) ---- PASS: TestRcptUserDoesNotExist (0.03s) +2024-04-18 10:02:00.912362 127.0.0.1:58108 rejected from=from@localhost to=[doesnotexist@localhost] - local user does not exist +_ conn.go:297 SMTP.Conn 127.0.0.1:58108: error: RCPT failed: 550 5.1.1 Destination address is unknown (user does not exist) +--- PASS: TestRcptUserDoesNotExist (0.02s) === RUN TestTooMuchData -_ conn.go:689 SMTP.Conn 127.0.0.1:35098: Queued from from@from to [to@localhost] - BxrfskkLpLQ -2024-04-18 09:57:36.834675 BxrfskkLpLQ from=from@from queued ip=127.0.0.1:35098 to=[to@localhost] -_ queue.go:308 Queue.SendLoop BxrfskkLpLQ: from from@from -_ queue.go:367 Queue.SendLoop BxrfskkLpLQ: testuser@localhost sent -2024-04-18 09:57:36.835092 BxrfskkLpLQ from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop BxrfskkLpLQ: all done -2024-04-18 09:57:37.460835 BxrfskkLpLQ from=from@from all done -_ conn.go:689 SMTP.Conn 127.0.0.1:35098: Queued from from@from to [to@localhost] - 4lHO_EPttQk -2024-04-18 09:57:37.782294 4lHO_EPttQk from=from@from queued ip=127.0.0.1:35098 to=[to@localhost] -_ queue.go:308 Queue.SendLoop 4lHO_EPttQk: from from@from -_ queue.go:367 Queue.SendLoop 4lHO_EPttQk: testuser@localhost sent -2024-04-18 09:57:37.782690 4lHO_EPttQk from=from@from to=testuser@localhost sent -_ queue.go:342 Queue.SendLoop 4lHO_EPttQk: all done -2024-04-18 09:57:38.301391 4lHO_EPttQk from=from@from all done -_ conn.go:297 SMTP.Conn 127.0.0.1:35098: error: DATA failed: 552 5.3.4 Message too big -_ conn.go:689 SMTP.Conn 127.0.0.1:35098: Queued from from@from to [to@localhost] - dcg-klz-mJI -2024-04-18 09:57:39.806388 dcg-klz-mJI from=from@from queued ip=127.0.0.1:35098 to=[to@localhost] -_ queue.go:308 Queue.SendLoop dcg-klz-mJI: from from@from -_ queue.go:367 Queue.SendLoop dcg-klz-mJI: testuser@localhost sent ---- PASS: TestTooMuchData (4.08s) +_ conn.go:689 SMTP.Conn 127.0.0.1:58112: Queued from from@from to [to@localhost] - jdfHRGFOX6w +2024-04-18 10:02:01.246081 jdfHRGFOX6w from=from@from queued ip=127.0.0.1:58112 to=[to@localhost] +_ queue.go:308 Queue.SendLoop jdfHRGFOX6w: from from@from +_ queue.go:367 Queue.SendLoop jdfHRGFOX6w: testuser@localhost sent +2024-04-18 10:02:01.246408 jdfHRGFOX6w from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop jdfHRGFOX6w: all done +2024-04-18 10:02:01.316443 jdfHRGFOX6w from=from@from all done +_ conn.go:689 SMTP.Conn 127.0.0.1:58112: Queued from from@from to [to@localhost] - 6KYhpKBSscM +2024-04-18 10:02:01.602603 6KYhpKBSscM from=from@from queued ip=127.0.0.1:58112 to=[to@localhost] +_ queue.go:308 Queue.SendLoop 6KYhpKBSscM: from from@from +_ queue.go:367 Queue.SendLoop 6KYhpKBSscM: testuser@localhost sent +2024-04-18 10:02:01.602886 6KYhpKBSscM from=from@from to=testuser@localhost sent +_ queue.go:342 Queue.SendLoop 6KYhpKBSscM: all done +2024-04-18 10:02:01.636181 6KYhpKBSscM from=from@from all done +_ conn.go:297 SMTP.Conn 127.0.0.1:58112: error: DATA failed: 552 5.3.4 Message too big +_ conn.go:689 SMTP.Conn 127.0.0.1:58112: Queued from from@from to [to@localhost] - f0LuHi0x1iQ +2024-04-18 10:02:02.253129 f0LuHi0x1iQ from=from@from queued ip=127.0.0.1:58112 to=[to@localhost] +_ queue.go:308 Queue.SendLoop f0LuHi0x1iQ: from from@from +_ queue.go:367 Queue.SendLoop f0LuHi0x1iQ: testuser@localhost sent +2024-04-18 10:02:02.253421 f0LuHi0x1iQ from=from@from to=testuser@localhost sent +--- PASS: TestTooMuchData (1.34s) === RUN TestSimpleCommands -_ conn.go:297 SMTP.Conn 127.0.0.1:35108: error: VRFY failed: 502 5.5.1 You have a strange feeling for a moment, then it passes. -_ conn.go:297 SMTP.Conn 127.0.0.1:35108: error: EXPN failed: 502 5.5.1 You feel disoriented for a moment. +_ conn.go:297 SMTP.Conn 127.0.0.1:58116: error: VRFY failed: 502 5.5.1 You have a strange feeling for a moment, then it passes. +_ conn.go:297 SMTP.Conn 127.0.0.1:58116: error: EXPN failed: 502 5.5.1 You feel disoriented for a moment. --- PASS: TestSimpleCommands (0.00s) -2024-04-18 09:57:39.806896 dcg-klz-mJI from=from@from to=testuser@localhost sent === RUN TestLongLines -_ conn.go:297 SMTP.Conn 127.0.0.1:35120: error: unknown<\"\"> failed: 500 5.5.1 Unknown command -_ conn.go:327 SMTP.Conn 127.0.0.1:35120: error: exiting with error: line too long ---- PASS: TestLongLines (0.01s) +_ conn.go:297 SMTP.Conn 127.0.0.1:58126: error: unknown<\"\"> failed: 500 5.5.1 Unknown command +_ conn.go:327 SMTP.Conn 127.0.0.1:58126: error: exiting with error: line too long +--- PASS: TestLongLines (0.00s) === RUN TestReset ---- PASS: TestReset (0.01s) +--- PASS: TestReset (0.00s) === RUN TestRepeatedStartTLS -_ conn.go:297 SMTP.Conn 127.0.0.1:35128: error: STARTTLS failed: 503 5.5.1 You are already wearing that! ---- PASS: TestRepeatedStartTLS (0.06s) +_ conn.go:297 SMTP.Conn 127.0.0.1:58152: error: STARTTLS failed: 503 5.5.1 You are already wearing that! +--- PASS: TestRepeatedStartTLS (0.02s) === RUN TestStartTLSOnTLS -_ conn.go:297 SMTP.Conn 127.0.0.1:48486: error: STARTTLS failed: 503 5.5.1 You are already wearing that! ---- PASS: TestStartTLSOnTLS (0.05s) +_ queue.go:342 Queue.SendLoop f0LuHi0x1iQ: all done +2024-04-18 10:02:02.287364 f0LuHi0x1iQ from=from@from all done +_ conn.go:297 SMTP.Conn 127.0.0.1:39524: error: STARTTLS failed: 503 5.5.1 You are already wearing that! +--- PASS: TestStartTLSOnTLS (0.02s) === RUN FuzzConnection === RUN FuzzConnection/3d7e992212e817da7afdb7a4e769ceec1d4047a2e630bec4b35ecd4d55560424 -_ conn.go:297 SMTP.Conn 127.0.0.1:35138: error: RCPT failed: 500 5.5.2 Unknown command -_ conn.go:297 SMTP.Conn 127.0.0.1:35138: error: RCPT failed: 500 5.5.4 Malformed command: EOF -_ conn.go:297 SMTP.Conn 127.0.0.1:35138: error: RCPT failed: 501 5.1.3 Malformed destination address -_ conn.go:304 SMTP.Conn 127.0.0.1:35138: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:58164: error: RCPT failed: 500 5.5.2 Unknown command +_ conn.go:297 SMTP.Conn 127.0.0.1:58164: error: RCPT failed: 500 5.5.4 Malformed command: EOF +_ conn.go:297 SMTP.Conn 127.0.0.1:58164: error: RCPT failed: 501 5.1.3 Malformed destination address +_ conn.go:304 SMTP.Conn 127.0.0.1:58164: error: too many errors, breaking connection === RUN FuzzConnection/68d8c7b5f149996ffd46ad9a15852165d8c1cbd6c03cceb9382e5add16415c94 -_ conn.go:297 SMTP.Conn 127.0.0.1:35146: error: DATA failed: 503 5.5.1 Invisible customers are not welcome! -_ conn.go:297 SMTP.Conn 127.0.0.1:35146: error: DATA failed: 503 5.5.1 Sender not yet given +_ conn.go:297 SMTP.Conn 127.0.0.1:58168: error: DATA failed: 503 5.5.1 Invisible customers are not welcome! +_ conn.go:297 SMTP.Conn 127.0.0.1:58168: error: DATA failed: 503 5.5.1 Sender not yet given +2024-04-18 10:02:02.304292 127.0.0.1:58168 rejected from=a@b to=[user@testserver] - relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:58168: error: RCPT failed: 503 5.7.1 Relay not allowed +_ conn.go:304 SMTP.Conn 127.0.0.1:58168: error: too many errors, breaking connection === RUN FuzzConnection/79e51b30c215fb19a29855deebf2ed8299b35ca6f14db9681ee504e216c44a7f -2024-04-18 09:57:40.033728 127.0.0.1:35146 rejected from=a@b to=[user@testserver] - relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:35146: error: RCPT failed: 503 5.7.1 Relay not allowed -_ conn.go:304 SMTP.Conn 127.0.0.1:35146: error: too many errors, breaking connection -2024-04-18 09:57:40.036760 127.0.0.1:35150 rejected from=<> to=[user@testserver] - relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:35150: error: RCPT failed: 503 5.7.1 Relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:35150: error: DATA failed: 503 5.5.1 Need an address to send to -_ conn.go:297 SMTP.Conn 127.0.0.1:35150: error: unknown<\"FROM:\"> failed: 500 5.5.1 Unknown command -_ conn.go:304 SMTP.Conn 127.0.0.1:35150: error: too many errors, breaking connection +2024-04-18 10:02:02.305531 127.0.0.1:58176 rejected from=<> to=[user@testserver] - relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:58176: error: RCPT failed: 503 5.7.1 Relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:58176: error: DATA failed: 503 5.5.1 Need an address to send to +_ conn.go:297 SMTP.Conn 127.0.0.1:58176: error: unknown<\"FROM:\"> failed: 500 5.5.1 Unknown command +_ conn.go:304 SMTP.Conn 127.0.0.1:58176: error: too many errors, breaking connection === RUN FuzzConnection/83ab02fccf91c1b9c0c972de745dc2a45d23dc3236f9027e605c3e017d8898fe -_ conn.go:297 SMTP.Conn 127.0.0.1:35154: error: MAIL failed: 500 5.5.2 Unknown command -_ conn.go:297 SMTP.Conn 127.0.0.1:35154: error: MAIL failed: 500 5.5.4 Malformed command: EOF -_ conn.go:297 SMTP.Conn 127.0.0.1:35154: error: MAIL failed: 501 5.1.7 Sender address malformed -_ conn.go:304 SMTP.Conn 127.0.0.1:35154: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:58184: error: MAIL failed: 500 5.5.2 Unknown command +_ conn.go:297 SMTP.Conn 127.0.0.1:58184: error: MAIL failed: 500 5.5.4 Malformed command: EOF +_ conn.go:297 SMTP.Conn 127.0.0.1:58184: error: MAIL failed: 501 5.1.7 Sender address malformed +_ conn.go:304 SMTP.Conn 127.0.0.1:58184: error: too many errors, breaking connection === RUN FuzzConnection/a24124ade554d7a25de538f2cbbced6245ba60e90d221e51590456e222c80359 -_ conn.go:297 SMTP.Conn 127.0.0.1:35158: error: HELO failed: 501 Invisible customers are not welcome! -_ conn.go:297 SMTP.Conn 127.0.0.1:35158: error: EHLO failed: 501 Invisible customers are not welcome! +_ conn.go:297 SMTP.Conn 127.0.0.1:58188: error: HELO failed: 501 Invisible customers are not welcome! +_ conn.go:297 SMTP.Conn 127.0.0.1:58188: error: EHLO failed: 501 Invisible customers are not welcome! === RUN FuzzConnection/b896b41db27f6e36e4e727ac4f7b3d02fad34d217855c0d433ea3a325951b3bf === RUN FuzzConnection/bf15e6fb937795251090940ac60a37705b36a13e71a9557e7aaf0618ea2cf661 -2024-04-18 09:57:40.049863 127.0.0.1:35190 rejected from=<> to=[user@testserver] - relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:35190: error: RCPT failed: 503 5.7.1 Relay not allowed -_ conn.go:297 SMTP.Conn 127.0.0.1:35190: error: DATA failed: 503 5.5.1 Need an address to send to -_ conn.go:297 SMTP.Conn 127.0.0.1:35190: error: unknown<\"FROM:\"> failed: 500 5.5.1 Unknown command -_ conn.go:304 SMTP.Conn 127.0.0.1:35190: error: too many errors, breaking connection +2024-04-18 10:02:02.311165 127.0.0.1:58206 rejected from=<> to=[user@testserver] - relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:58206: error: RCPT failed: 503 5.7.1 Relay not allowed +_ conn.go:297 SMTP.Conn 127.0.0.1:58206: error: DATA failed: 503 5.5.1 Need an address to send to +_ conn.go:297 SMTP.Conn 127.0.0.1:58206: error: unknown<\"FROM:\"> failed: 500 5.5.1 Unknown command +_ conn.go:304 SMTP.Conn 127.0.0.1:58206: error: too many errors, breaking connection === RUN FuzzConnection/d1b1ccbbb380c53282cc2689c4bd9ff0d03a03698e9be55371739ef95d7dd671 -_ conn.go:297 SMTP.Conn 127.0.0.1:35200: error: AUTH failed: 503 5.7.10 You feel vulnerable -_ conn.go:297 SMTP.Conn 127.0.0.1:35200: error: AUTH failed: 503 5.7.10 You feel vulnerable -_ conn.go:297 SMTP.Conn 127.0.0.1:35200: error: AUTH failed: 503 5.7.10 You feel vulnerable -_ conn.go:304 SMTP.Conn 127.0.0.1:35200: error: too many errors, breaking connection +_ conn.go:297 SMTP.Conn 127.0.0.1:58210: error: AUTH failed: 503 5.7.10 You feel vulnerable +_ conn.go:297 SMTP.Conn 127.0.0.1:58210: error: AUTH failed: 503 5.7.10 You feel vulnerable +_ conn.go:297 SMTP.Conn 127.0.0.1:58210: error: AUTH failed: 503 5.7.10 You feel vulnerable +_ conn.go:304 SMTP.Conn 127.0.0.1:58210: error: too many errors, breaking connection === RUN FuzzConnection/dc70e53325976a3a1067feb0b0c956c5a9abec1c867f8198808ccff83f594ded +_ conn.go:297 SMTP.Conn 127.0.0.1:58220: error: unknown<\"WHATIS\"> failed: 500 5.5.1 Unknown command === RUN FuzzConnection/e7682fde78ce0d78ddc7a818f151b6f04466a2c122197a2e4e8048d194ed72c2 -_ conn.go:297 SMTP.Conn 127.0.0.1:35208: error: unknown<\"WHATIS\"> failed: 500 5.5.1 Unknown command +_ conn.go:297 SMTP.Conn 127.0.0.1:58236: error: AUTH failed: 503 5.7.10 You feel vulnerable === RUN FuzzConnection/fd41d0c11b1bb7f89825934b2ec51db1df166e34b4610e8089549eedf2e3635c -_ conn.go:297 SMTP.Conn 127.0.0.1:35216: error: AUTH failed: 503 5.7.10 You feel vulnerable -_ conn.go:297 SMTP.Conn 127.0.0.1:48492: error: AUTH failed: 534 5.7.9 Asmodeus demands 534 zorkmids for safe passage -_ conn.go:297 SMTP.Conn 127.0.0.1:48492: error: AUTH failed: 501 5.5.2 Error decoding AUTH response: illegal base64 data at input byte 28 -2024-04-18 09:57:40.201955 127.0.0.1:48492 auth failed for user@testserver -_ conn.go:297 SMTP.Conn 127.0.0.1:48492: error: AUTH failed: 535 5.7.8 Incorrect user or password -_ conn.go:304 SMTP.Conn 127.0.0.1:48492: error: too many errors, breaking connection ---- PASS: FuzzConnection (0.27s) +_ conn.go:297 SMTP.Conn 127.0.0.1:39532: error: AUTH failed: 534 5.7.9 Asmodeus demands 534 zorkmids for safe passage +_ conn.go:297 SMTP.Conn 127.0.0.1:39532: error: AUTH failed: 501 5.5.2 Error decoding AUTH response: illegal base64 data at input byte 28 +2024-04-18 10:02:02.442263 127.0.0.1:39532 auth failed for user@testserver +_ conn.go:297 SMTP.Conn 127.0.0.1:39532: error: AUTH failed: 535 5.7.8 Incorrect user or password +_ conn.go:304 SMTP.Conn 127.0.0.1:39532: error: too many errors, breaking connection +--- PASS: FuzzConnection (0.15s) --- PASS: FuzzConnection/3d7e992212e817da7afdb7a4e769ceec1d4047a2e630bec4b35ecd4d55560424 (0.00s) --- PASS: FuzzConnection/68d8c7b5f149996ffd46ad9a15852165d8c1cbd6c03cceb9382e5add16415c94 (0.00s) --- PASS: FuzzConnection/79e51b30c215fb19a29855deebf2ed8299b35ca6f14db9681ee504e216c44a7f (0.00s) --- PASS: FuzzConnection/83ab02fccf91c1b9c0c972de745dc2a45d23dc3236f9027e605c3e017d8898fe (0.00s) --- PASS: FuzzConnection/a24124ade554d7a25de538f2cbbced6245ba60e90d221e51590456e222c80359 (0.00s) --- PASS: FuzzConnection/b896b41db27f6e36e4e727ac4f7b3d02fad34d217855c0d433ea3a325951b3bf (0.00s) - --- PASS: FuzzConnection/bf15e6fb937795251090940ac60a37705b36a13e71a9557e7aaf0618ea2cf661 (0.01s) + --- PASS: FuzzConnection/bf15e6fb937795251090940ac60a37705b36a13e71a9557e7aaf0618ea2cf661 (0.00s) --- PASS: FuzzConnection/d1b1ccbbb380c53282cc2689c4bd9ff0d03a03698e9be55371739ef95d7dd671 (0.00s) --- PASS: FuzzConnection/dc70e53325976a3a1067feb0b0c956c5a9abec1c867f8198808ccff83f594ded (0.00s) --- PASS: FuzzConnection/e7682fde78ce0d78ddc7a818f151b6f04466a2c122197a2e4e8048d194ed72c2 (0.00s) - --- PASS: FuzzConnection/fd41d0c11b1bb7f89825934b2ec51db1df166e34b4610e8089549eedf2e3635c (0.14s) + --- PASS: FuzzConnection/fd41d0c11b1bb7f89825934b2ec51db1df166e34b4610e8089549eedf2e3635c (0.13s) PASS -_ queue.go:342 Queue.SendLoop dcg-klz-mJI: all done -2024-04-18 09:57:40.356797 dcg-klz-mJI from=from@from all done -E queue.go:230 failed to remove queue file "/tmp/chasquid_test:4231004200/queue/m:dcg-klz-mJI": remove /tmp/chasquid_test:4231004200/queue/m:dcg-klz-mJI: no such file or directory -ok blitiri.com.ar/go/chasquid/internal/smtpsrv 8.127s +ok blitiri.com.ar/go/chasquid/internal/smtpsrv 3.272s === RUN TestParsePolicy sts_test.go:90: pol1: &{Version:STSv1 Mode:enforce MXs:[*.mail.example.com] MaxAge:34h17m36s} --- PASS: TestParsePolicy (0.00s) @@ -1590,29 +1623,29 @@ sts_test.go:242: got error as expected: MTA-STS TXT record missing --- PASS: TestPolicyTooBig (0.07s) === RUN TestCacheBasics - testlib.go:32: test directory: "/tmp/testlib_3218295174" + testlib.go:32: test directory: "/tmp/testlib_2388907458" sts_test.go:277: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:286: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:300: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:309: cache fetched domErr: ---- PASS: TestCacheBasics (0.01s) +--- PASS: TestCacheBasics (0.00s) === RUN TestCacheBadData - testlib.go:32: test directory: "/tmp/testlib_1743103407" + testlib.go:32: test directory: "/tmp/testlib_4253982939" sts_test.go:349: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:363: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:372: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:349: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:363: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} sts_test.go:372: cache fetched domain.com: &{STSv1 enforce [*.mail.domain.com] 1h0m0s} ---- PASS: TestCacheBadData (0.02s) +--- PASS: TestCacheBadData (0.03s) === RUN TestCacheRefresh - testlib.go:32: test directory: "/tmp/testlib_1142604388" + testlib.go:32: test directory: "/tmp/testlib_172163745" 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_2577801672" + testlib.go:32: test directory: "/tmp/testlib_36658913" sts_test.go:464: recovered: domain contains slash --- PASS: TestCacheSlashSafe (0.00s) === RUN TestURLForDomain @@ -1620,11 +1653,11 @@ === RUN TestHasSTSRecord --- PASS: TestHasSTSRecord (0.00s) === RUN TestHTTPGet ---- PASS: TestHTTPGet (0.01s) +--- PASS: TestHTTPGet (0.00s) PASS ok blitiri.com.ar/go/chasquid/internal/sts 0.149s === RUN TestBasic - testlib.go:32: test directory: "/tmp/testlib_1587737827" + testlib.go:32: test directory: "/tmp/testlib_1828433946" --- PASS: TestBasic (0.00s) === RUN TestRemoveCheck testlib_test.go:33: recovered: invalid/dangerous directory @@ -1635,54 +1668,54 @@ testlib_test.go:60: recovered: invalid/dangerous path --- PASS: TestRewriteSafeguard (0.00s) === RUN TestRewrite - testlib.go:32: test directory: "/tmp/testlib_316462643" + testlib.go:32: test directory: "/tmp/testlib_3946171343" --- PASS: TestRewrite (0.00s) === RUN TestGetFreePort ---- PASS: TestGetFreePort (0.00s) +--- PASS: TestGetFreePort (0.01s) === RUN TestWaitFor --- PASS: TestWaitFor (0.02s) === RUN TestGenerateCert - testlib.go:32: test directory: "/tmp/testlib_2171454304" ---- PASS: TestGenerateCert (1.10s) + testlib.go:32: test directory: "/tmp/testlib_3134723067" +--- PASS: TestGenerateCert (0.20s) === RUN TestGenerateCertBadDir ---- PASS: TestGenerateCertBadDir (0.53s) +--- PASS: TestGenerateCertBadDir (0.24s) PASS -ok blitiri.com.ar/go/chasquid/internal/testlib 1.679s +ok blitiri.com.ar/go/chasquid/internal/testlib 0.484s === RUN TestVersionName --- PASS: TestVersionName (0.00s) === RUN TestCipherSuiteName --- PASS: TestCipherSuiteName (0.00s) PASS -ok blitiri.com.ar/go/chasquid/internal/tlsconst 0.008s +ok blitiri.com.ar/go/chasquid/internal/tlsconst 0.015s === RUN TestEmptyLoad - userdb_test.go:37: file: "/tmp/userdb_test433016490" - userdb_test.go:37: file: "/tmp/userdb_test807503574" + userdb_test.go:37: file: "/tmp/userdb_test929044950" + userdb_test.go:37: file: "/tmp/userdb_test2595573063" --- PASS: TestEmptyLoad (0.00s) === RUN TestWrite - userdb_test.go:37: file: "/tmp/userdb_test3256872219" ---- PASS: TestWrite (2.57s) + userdb_test.go:37: file: "/tmp/userdb_test1584071483" +--- PASS: TestWrite (0.90s) === RUN TestNew ---- PASS: TestNew (0.35s) +--- PASS: TestNew (0.12s) === RUN TestInvalidUsername - userdb_test.go:37: file: "/tmp/userdb_test1838606021" + userdb_test.go:37: file: "/tmp/userdb_test3618333126" --- PASS: TestInvalidUsername (0.00s) === RUN TestPlainScheme - userdb_test.go:37: file: "/tmp/userdb_test1277255892" ---- PASS: TestPlainScheme (0.01s) + userdb_test.go:37: file: "/tmp/userdb_test2538620956" +--- PASS: TestPlainScheme (0.00s) === RUN TestDeniedScheme - userdb_test.go:37: file: "/tmp/userdb_test2096087822" ---- PASS: TestDeniedScheme (0.02s) + userdb_test.go:37: file: "/tmp/userdb_test1845142559" +--- PASS: TestDeniedScheme (0.00s) === RUN TestReload - userdb_test.go:37: file: "/tmp/userdb_test1693342682" ---- PASS: TestReload (0.04s) + userdb_test.go:37: file: "/tmp/userdb_test1378078121" +--- PASS: TestReload (0.00s) === RUN TestRemoveUser - userdb_test.go:37: file: "/tmp/userdb_test1375381748" ---- PASS: TestRemoveUser (0.45s) + userdb_test.go:37: file: "/tmp/userdb_test2092939031" +--- PASS: TestRemoveUser (0.15s) === RUN TestExists - userdb_test.go:37: file: "/tmp/userdb_test4191932390" ---- PASS: TestExists (0.47s) + userdb_test.go:37: file: "/tmp/userdb_test659566468" +--- PASS: TestExists (0.13s) PASS -ok blitiri.com.ar/go/chasquid/internal/userdb 3.953s +ok blitiri.com.ar/go/chasquid/internal/userdb 1.320s create-stamp debian/debhelper-build-stamp dh_testroot -O--buildsystem=golang dh_prep -O--buildsystem=golang @@ -1727,10 +1760,10 @@ dh_fixperms -O--buildsystem=golang dh_missing -O--buildsystem=golang dh_strip -a -O--buildsystem=golang -dh_strip: warning: Could not find the BuildID in debian/chasquid/usr/bin/smtp-check dh_strip: warning: Could not find the BuildID in debian/chasquid/usr/bin/chasquid-util -dh_strip: warning: Could not find the BuildID in debian/chasquid/usr/bin/mda-lmtp dh_strip: warning: Could not find the BuildID in debian/chasquid/usr/bin/chasquid +dh_strip: warning: Could not find the BuildID in debian/chasquid/usr/bin/mda-lmtp +dh_strip: warning: Could not find the BuildID in debian/chasquid/usr/bin/smtp-check dh_makeshlibs -a -O--buildsystem=golang dh_shlibdeps -a -O--buildsystem=golang dh_installdeb -O--buildsystem=golang @@ -1747,12 +1780,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: including full source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/1634/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/1634/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/26326 and its subdirectories -I: Current time: Wed Apr 17 21:58:55 -12 2024 -I: pbuilder-time-stamp: 1713434335 +I: removing directory /srv/workspace/pbuilder/1634 and its subdirectories +I: Current time: Fri Apr 19 00:02:40 +14 2024 +I: pbuilder-time-stamp: 1713434560