Diff of the two buildlogs: -- --- b1/build.log 2024-04-18 06:37:11.622701124 +0000 +++ b2/build.log 2024-04-18 06:47:41.595782306 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed Apr 17 18:31:04 -12 2024 -I: pbuilder-time-stamp: 1713421864 +I: Current time: Thu Apr 18 20:38:49 +14 2024 +I: pbuilder-time-stamp: 1713422329 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -28,52 +28,84 @@ dpkg-source: info: applying 0001-fts5-package.diff I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/6881/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/16002/tmp/hooks/D01_modify_environment starting +debug: Running on virt32z. +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 06:39 /bin/sh -> /bin/bash +I: Setting pbuilder2's login shell to /bin/bash +I: Setting pbuilder2's GECOS to second user,second room,second work-phone,second home-phone,second other +I: user script /srv/workspace/pbuilder/16002/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/16002/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='5757c62eb8844802a63f0b8a6e85f621' - 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='6881' - PS1='# ' - PS2='> ' + INVOCATION_ID=298494224d234175919e97eda996942f + 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=16002 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.2OBbt8oY/pbuilderrc_L1Yr --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.2OBbt8oY/b1 --logfile b1/build.log soju_0.7.0-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.2OBbt8oY/pbuilderrc_XUzy --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.2OBbt8oY/b2 --logfile b2/build.log soju_0.7.0-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 virt64b 6.1.0-20-arm64 #1 SMP Debian 6.1.85-1 (2024-04-11) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-20-armmp-lpae #1 SMP Debian 6.1.85-1 (2024-04-11) armv7l GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Apr 17 11:24 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/6881/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Apr 16 11:24 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/16002/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -259,7 +291,7 @@ Get: 114 http://deb.debian.org/debian trixie/main armhf golang-sourcehut-sircmpwn-getopt-dev all 0.0~git20191230.23622cc-2 [9076 B] Get: 115 http://deb.debian.org/debian trixie/main armhf golang-sourcehut-sircmpwn-go-bare-dev all 0.0~git20210406.ab86bc2-2 [22.1 kB] Get: 116 http://deb.debian.org/debian trixie/main armhf scdoc armhf 1.11.3-1 [13.2 kB] -Fetched 123 MB in 3s (43.1 MB/s) +Fetched 123 MB in 3s (40.3 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.) @@ -738,7 +770,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/soju-0.7.0/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-genchanges -S > ../soju_0.7.0-1_source.changes +I: user script /srv/workspace/pbuilder/16002/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/16002/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/soju-0.7.0/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-genchanges -S > ../soju_0.7.0-1_source.changes dpkg-buildpackage: info: source package soju dpkg-buildpackage: info: source version 0.7.0-1 dpkg-buildpackage: info: source distribution unstable @@ -758,20 +794,20 @@ debian/rules override_dh_auto_build make[1]: Entering directory '/build/reproducible-path/soju-0.7.0' dh_auto_build -O--buildsystem=golang -- -tags="pam" -ldflags="-X 'git.sr.ht/~emersion/soju/config.DefaultPath=/etc/soju/config'" - cd _build && go install -trimpath -v -p 3 -tags=pam "-ldflags=-X 'git.sr.ht/~emersion/soju/config.DefaultPath=/etc/soju/config'" git.sr.ht/\~emersion/soju git.sr.ht/\~emersion/soju/auth git.sr.ht/\~emersion/soju/cmd/soju git.sr.ht/\~emersion/soju/cmd/sojuctl git.sr.ht/\~emersion/soju/cmd/sojudb git.sr.ht/\~emersion/soju/config git.sr.ht/\~emersion/soju/contrib/migrate-db git.sr.ht/\~emersion/soju/contrib/migrate-logs git.sr.ht/\~emersion/soju/contrib/znc-import git.sr.ht/\~emersion/soju/database git.sr.ht/\~emersion/soju/identd git.sr.ht/\~emersion/soju/msgstore git.sr.ht/\~emersion/soju/msgstore/znclog git.sr.ht/\~emersion/soju/xirc + cd _build && go install -trimpath -v -p 4 -tags=pam "-ldflags=-X 'git.sr.ht/~emersion/soju/config.DefaultPath=/etc/soju/config'" git.sr.ht/\~emersion/soju git.sr.ht/\~emersion/soju/auth git.sr.ht/\~emersion/soju/cmd/soju git.sr.ht/\~emersion/soju/cmd/sojuctl git.sr.ht/\~emersion/soju/cmd/sojudb git.sr.ht/\~emersion/soju/config git.sr.ht/\~emersion/soju/contrib/migrate-db git.sr.ht/\~emersion/soju/contrib/migrate-logs git.sr.ht/\~emersion/soju/contrib/znc-import git.sr.ht/\~emersion/soju/database git.sr.ht/\~emersion/soju/identd git.sr.ht/\~emersion/soju/msgstore git.sr.ht/\~emersion/soju/msgstore/znclog git.sr.ht/\~emersion/soju/xirc internal/unsafeheader +internal/coverage/rtcov internal/goarch +internal/godebugs internal/cpu -internal/coverage/rtcov -internal/abi internal/chacha8rand -internal/bytealg -internal/godebugs internal/goexperiment +internal/abi internal/goos -runtime/internal/atomic runtime/internal/math runtime/internal/sys +internal/bytealg +runtime/internal/atomic runtime/internal/syscall internal/race sync/atomic @@ -779,13 +815,13 @@ unicode/utf8 internal/itoa math/bits -runtime -math crypto/internal/alias crypto/internal/boring/sig cmp +math slices unicode/utf16 +runtime vendor/golang.org/x/crypto/cryptobyte/asn1 container/list internal/nettrace @@ -796,128 +832,130 @@ google.golang.org/protobuf/internal/flags google.golang.org/protobuf/internal/set internal/reflectlite -crypto/subtle sync +crypto/subtle runtime/metrics internal/testlog -internal/bisect internal/singleflight +internal/bisect +google.golang.org/protobuf/internal/pragma runtime/cgo errors sort +internal/godebug io -bytes internal/oserror +strconv +bytes syscall hash -strconv +crypto/internal/nistec/fiat crypto reflect time -crypto/internal/nistec/fiat context +crypto/internal/nistec crypto/internal/randutil internal/syscall/unix -internal/poll -encoding/binary -internal/fmtsort -crypto/cipher -crypto/internal/edwards25519/field internal/safefilepath -crypto/internal/boring internal/syscall/execenv path -crypto/aes +internal/poll io/fs -internal/godebug +encoding/binary +internal/fmtsort math/rand -os strings -fmt -crypto/internal/nistec -crypto/sha512 +os +crypto/rc4 +crypto/cipher +crypto/internal/edwards25519/field +crypto/md5 crypto/internal/edwards25519 +crypto/internal/boring +crypto/aes crypto/ecdh +crypto/sha512 crypto/sha1 -math/big crypto/sha256 crypto/des crypto/hmac -crypto/md5 -crypto/rc4 -encoding/hex encoding/base64 vendor/golang.org/x/net/dns/dnsmessage -encoding/pem +fmt internal/intern +encoding/pem net/netip -net/url -net path/filepath -crypto/elliptic -crypto/internal/bigmod -crypto/internal/boring/bbig -encoding/asn1 -crypto/rand -crypto/ed25519 -crypto/rsa -vendor/golang.org/x/crypto/cryptobyte -crypto/dsa -crypto/x509/pkix vendor/golang.org/x/crypto/chacha20 vendor/golang.org/x/crypto/internal/poly1305 -crypto/ecdsa -vendor/golang.org/x/crypto/chacha20poly1305 vendor/golang.org/x/crypto/hkdf +net +bufio +vendor/golang.org/x/crypto/chacha20poly1305 +regexp/syntax +io/ioutil +math/big +encoding/hex +net/url flag encoding/json database/sql/driver database/sql -bufio +crypto/elliptic +crypto/internal/bigmod +crypto/internal/boring/bbig +encoding/asn1 +crypto/rand +crypto/dsa golang.org/x/time/rate -regexp/syntax +crypto/ed25519 +crypto/rsa +regexp github.com/lib/pq/scram -io/ioutil +vendor/golang.org/x/crypto/cryptobyte +crypto/x509/pkix os/user -regexp gopkg.in/irc.v4 +crypto/ecdsa git.sr.ht/~emersion/soju/xirc github.com/mattn/go-sqlite3 log compress/flate -crypto/x509 hash/crc32 compress/gzip vendor/golang.org/x/text/transform vendor/golang.org/x/text/unicode/bidi -vendor/golang.org/x/text/secure/bidirule vendor/golang.org/x/text/unicode/norm -crypto/tls -vendor/golang.org/x/net/idna -net/textproto -vendor/golang.org/x/net/http/httpguts -vendor/golang.org/x/net/http/httpproxy +vendor/golang.org/x/text/secure/bidirule vendor/golang.org/x/net/http2/hpack mime +vendor/golang.org/x/net/idna mime/quotedprintable -mime/multipart net/http/internal net/http/internal/ascii -github.com/lib/pq -net/http/httptrace -net/http github.com/beorn7/perks/quantile github.com/cespare/xxhash hash/fnv +go/token google.golang.org/protobuf/internal/detrand +crypto/x509 +net/textproto +vendor/golang.org/x/net/http/httpproxy google.golang.org/protobuf/internal/errors google.golang.org/protobuf/encoding/protowire -google.golang.org/protobuf/internal/pragma +vendor/golang.org/x/net/http/httpguts +mime/multipart google.golang.org/protobuf/reflect/protoreflect +google.golang.org/protobuf/internal/version +github.com/prometheus/common/internal/bitbucket.org/ww/goautoneg +github.com/prometheus/procfs/internal/fs +github.com/prometheus/procfs/internal/util google.golang.org/protobuf/internal/descfmt +golang.org/x/sys/unix google.golang.org/protobuf/internal/descopts -go/token google.golang.org/protobuf/internal/strs +crypto/tls google.golang.org/protobuf/internal/encoding/text google.golang.org/protobuf/internal/encoding/defval google.golang.org/protobuf/internal/encoding/messageset @@ -927,72 +965,70 @@ google.golang.org/protobuf/runtime/protoiface google.golang.org/protobuf/proto google.golang.org/protobuf/internal/filedesc -expvar google.golang.org/protobuf/encoding/prototext +github.com/lib/pq +net/http/httptrace +net/http google.golang.org/protobuf/internal/encoding/tag -google.golang.org/protobuf/internal/version -github.com/prometheus/common/internal/bitbucket.org/ww/goautoneg -google.golang.org/protobuf/encoding/protodelim -github.com/prometheus/procfs/internal/fs google.golang.org/protobuf/internal/impl -github.com/prometheus/procfs/internal/util -golang.org/x/sys/unix +google.golang.org/protobuf/encoding/protodelim +github.com/prometheus/procfs runtime/debug golang.org/x/crypto/blowfish golang.org/x/crypto/bcrypt github.com/msteinert/pam -github.com/prometheus/procfs -git.sr.ht/~emersion/go-scfg -git.sr.ht/~emersion/soju/config -git.sr.ht/~emersion/soju/identd -git.sr.ht/~sircmpwn/go-bare google.golang.org/protobuf/internal/filetype -github.com/golang-jwt/jwt google.golang.org/protobuf/runtime/protoimpl google.golang.org/protobuf/types/known/timestamppb github.com/prometheus/client_model/go -golang.org/x/crypto/hkdf -github.com/SherClockHolmes/webpush-go github.com/prometheus/common/model +git.sr.ht/~emersion/go-scfg +expvar +git.sr.ht/~emersion/soju/config +git.sr.ht/~emersion/soju/identd +git.sr.ht/~sircmpwn/go-bare +golang.org/x/crypto/hkdf +github.com/golang-jwt/jwt github.com/emersion/go-sasl github.com/klauspost/compress/flate +github.com/prometheus/client_golang/prometheus/internal +github.com/prometheus/common/expfmt +github.com/SherClockHolmes/webpush-go nhooyr.io/websocket/internal/errd nhooyr.io/websocket/internal/xsync github.com/pires/go-proxyproto -github.com/prometheus/client_golang/prometheus/internal -github.com/prometheus/common/expfmt html internal/lazyregexp -internal/profile -nhooyr.io/websocket github.com/prometheus/client_golang/prometheus text/tabwriter -runtime/trace +internal/profile runtime/pprof +nhooyr.io/websocket +runtime/trace os/signal -git.sr.ht/~emersion/soju/cmd/sojuctl net/http/pprof +git.sr.ht/~emersion/soju/cmd/sojuctl golang.org/x/term +golang.org/x/crypto/ssh/terminal github.com/prometheus/client_golang/prometheus/collectors github.com/prometheus/client_golang/prometheus/promauto github.com/prometheus/client_golang/prometheus/promhttp -golang.org/x/crypto/ssh/terminal git.sr.ht/~emersion/soju/database -git.sr.ht/~emersion/soju/msgstore/znclog git.sr.ht/~emersion/soju/auth git.sr.ht/~emersion/soju/cmd/sojudb -git.sr.ht/~emersion/soju/msgstore +git.sr.ht/~emersion/soju/msgstore/znclog git.sr.ht/~emersion/soju/contrib/migrate-db +git.sr.ht/~emersion/soju/msgstore +git.sr.ht/~emersion/soju/contrib/znc-import git.sr.ht/~emersion/soju git.sr.ht/~emersion/soju/contrib/migrate-logs -git.sr.ht/~emersion/soju/contrib/znc-import git.sr.ht/~emersion/soju/cmd/soju # Build man pages scdoc < doc/soju.1.scd > _build/soju.1 scdoc < doc/sojuctl.1.scd > _build/sojuctl.1 make[1]: Leaving directory '/build/reproducible-path/soju-0.7.0' dh_auto_test -O--builddirectory=_build -O--buildsystem=golang - cd _build && go test -vet=off -v -p 3 git.sr.ht/\~emersion/soju git.sr.ht/\~emersion/soju/auth git.sr.ht/\~emersion/soju/cmd/soju git.sr.ht/\~emersion/soju/cmd/sojuctl git.sr.ht/\~emersion/soju/cmd/sojudb git.sr.ht/\~emersion/soju/config git.sr.ht/\~emersion/soju/contrib/migrate-db git.sr.ht/\~emersion/soju/contrib/migrate-logs git.sr.ht/\~emersion/soju/contrib/znc-import git.sr.ht/\~emersion/soju/database git.sr.ht/\~emersion/soju/identd git.sr.ht/\~emersion/soju/msgstore git.sr.ht/\~emersion/soju/msgstore/znclog git.sr.ht/\~emersion/soju/xirc + cd _build && go test -vet=off -v -p 4 git.sr.ht/\~emersion/soju git.sr.ht/\~emersion/soju/auth git.sr.ht/\~emersion/soju/cmd/soju git.sr.ht/\~emersion/soju/cmd/sojuctl git.sr.ht/\~emersion/soju/cmd/sojudb git.sr.ht/\~emersion/soju/config git.sr.ht/\~emersion/soju/contrib/migrate-db git.sr.ht/\~emersion/soju/contrib/migrate-logs git.sr.ht/\~emersion/soju/contrib/znc-import git.sr.ht/\~emersion/soju/database git.sr.ht/\~emersion/soju/identd git.sr.ht/\~emersion/soju/msgstore git.sr.ht/\~emersion/soju/msgstore/znclog git.sr.ht/\~emersion/soju/xirc === RUN TestIsHighlight === RUN TestIsHighlight/noContains === RUN TestIsHighlight/middle @@ -1015,180 +1051,169 @@ --- PASS: TestIsHighlight/zeroWidthSpace (0.00s) === RUN TestServer_broadcast === RUN TestServer_broadcast/sqlite -2024/04/18 06:36:13 generating Web push VAPID key pair -2024/04/18 06:36:13 starting bouncer for user "soju-test-user" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connecting to plain-text server at address "127.0.0.1:37685" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": new connection -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: CAP LS 302 -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: NICK soju-test-user -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: USER soju-test-user 0 * soju-test-user -2024/04/18 06:36:13 downstream "pipe": new connection -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 001 soju-test-user Welcome! -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connection registered with nick "soju-test-user" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 002 soju-test-user :Your host is soju-test-server -2024/04/18 06:36:13 downstream "pipe": received: PASS soju-test-user -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 003 soju-test-user :Who cares when the server was created? -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 004 soju-test-user soju-test-server soju aiwroO OovaimnqpsrtklbeI -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 422 soju-test-user :No MOTD -2024/04/18 06:36:13 downstream "pipe": received: NICK soju-test-user -2024/04/18 06:36:13 downstream "pipe": received: USER soju-test-user/testnet 0 * soju-test-user -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: AWAY :Auto away -2024/04/18 06:36:13 downstream "pipe": registration complete for user "soju-test-user" -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 001 soju-test-user :Welcome to soju, soju-test-user -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: AWAY -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 002 soju-test-user :Your host is localhost -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 004 soju-test-user localhost soju aiwroO OovaimnqpsrtklbeI -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 005 * BOUNCER_NETID=1 CLIENTTAGDENY=* :are supported -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 221 soju-test-user + -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 422 soju-test-user :Use /motd to read the message of the day -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server NOTICE soju-test-user :This is a very important server notice. -2024/04/18 06:36:13 downstream "pipe": sent: :soju-test-server NOTICE soju-test-user :This is a very important server notice. -2024/04/18 06:36:13 shutting down server -2024/04/18 06:36:13 waiting for users to finish -2024/04/18 06:36:13 downstream "pipe": connection closed -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: AWAY :Auto away -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": failed to write message: write tcp 127.0.0.1:56382->127.0.0.1:37685: write: connection reset by peer -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connection closed -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connecting to plain-text server at address "127.0.0.1:37685" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": new connection -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": failed to send message: context canceled +2024/04/18 06:46:01 generating Web push VAPID key pair +2024/04/18 06:46:01 starting bouncer for user "soju-test-user" +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": connecting to plain-text server at address "127.0.0.1:33449" +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": new connection +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": sent: CAP LS 302 +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": sent: NICK soju-test-user +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": sent: USER soju-test-user 0 * soju-test-user +2024/04/18 06:46:01 downstream "pipe": new connection +2024/04/18 06:46:01 downstream "pipe": received: PASS soju-test-user +2024/04/18 06:46:01 downstream "pipe": received: NICK soju-test-user +2024/04/18 06:46:01 downstream "pipe": received: USER soju-test-user/testnet 0 * soju-test-user +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": received: :soju-test-server 001 soju-test-user Welcome! +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": connection registered with nick "soju-test-user" +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": received: :soju-test-server 002 soju-test-user :Your host is soju-test-server +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": received: :soju-test-server 003 soju-test-user :Who cares when the server was created? +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": received: :soju-test-server 004 soju-test-user soju-test-server soju aiwroO OovaimnqpsrtklbeI +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": received: :soju-test-server 422 soju-test-user :No MOTD +2024/04/18 06:46:01 user "soju-test-user": upstream "testnet": sent: AWAY :Auto away +2024/04/18 06:46:02 downstream "pipe": registration complete for user "soju-test-user" +2024/04/18 06:46:02 downstream "pipe": sent: :localhost 001 soju-test-user :Welcome to soju, soju-test-user +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": received: :soju-test-server NOTICE soju-test-user :This is a very important server notice. +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": sent: AWAY +2024/04/18 06:46:02 downstream "pipe": sent: :localhost 002 soju-test-user :Your host is localhost +2024/04/18 06:46:02 downstream "pipe": sent: :localhost 004 soju-test-user localhost soju aiwroO OovaimnqpsrtklbeI +2024/04/18 06:46:02 downstream "pipe": sent: :localhost 005 * BOUNCER_NETID=1 CLIENTTAGDENY=* :are supported +2024/04/18 06:46:02 downstream "pipe": sent: :localhost 221 soju-test-user + +2024/04/18 06:46:02 downstream "pipe": sent: :localhost 422 soju-test-user :Use /motd to read the message of the day +2024/04/18 06:46:02 downstream "pipe": sent: :soju-test-server NOTICE soju-test-user :This is a very important server notice. +2024/04/18 06:46:02 shutting down server +2024/04/18 06:46:02 waiting for users to finish +2024/04/18 06:46:02 downstream "pipe": connection closed +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": connection closed === RUN TestServer_broadcast/postgres -2024/04/18 06:36:13 user "soju-test-user": network "testnet": connection error to "irc+insecure://127.0.0.1:37685": failed to register: failed to read message: read tcp 127.0.0.1:56384->127.0.0.1:37685: read: connection reset by peer server_test.go:39: set SOJU_TEST_POSTGRES to a connection string to execute PostgreSQL tests -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: NICK soju-test-user -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": failed to write message: write tcp 127.0.0.1:56384->127.0.0.1:37685: use of closed network connection -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connection closed ---- PASS: TestServer_broadcast (0.29s) - --- PASS: TestServer_broadcast/sqlite (0.29s) +--- PASS: TestServer_broadcast (0.83s) + --- PASS: TestServer_broadcast/sqlite (0.83s) --- SKIP: TestServer_broadcast/postgres (0.00s) === RUN TestServer_chatHistory === RUN TestServer_chatHistory/fs -2024/04/18 06:36:13 generating Web push VAPID key pair -2024/04/18 06:36:13 starting bouncer for user "soju-test-user" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connecting to plain-text server at address "127.0.0.1:40369" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": new connection -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: CAP LS 302 -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: NICK soju-test-user -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: USER soju-test-user 0 * soju-test-user -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 001 soju-test-user Welcome! -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connection registered with nick "soju-test-user" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 002 soju-test-user :Your host is soju-test-server -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 003 soju-test-user :Who cares when the server was created? -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 004 soju-test-user soju-test-server soju aiwroO OovaimnqpsrtklbeI -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 422 soju-test-user :No MOTD -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:00.000Z :foo PRIVMSG soju-test-user Hiya! -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:01.000Z :foo PRIVMSG soju-test-user :How are you doing? -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:02.000Z :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: PING roundtrip -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: AWAY :Auto away -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: PONG roundtrip -2024/04/18 06:36:13 downstream "pipe": new connection -2024/04/18 06:36:13 downstream "pipe": received: PASS soju-test-user -2024/04/18 06:36:13 downstream "pipe": received: NICK soju-test-user -2024/04/18 06:36:13 downstream "pipe": received: USER soju-test-user/testnet 0 * soju-test-user -2024/04/18 06:36:13 downstream "pipe": registration complete for user "soju-test-user" -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 001 soju-test-user :Welcome to soju, soju-test-user -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: AWAY -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: PING roundtrip -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 002 soju-test-user :Your host is localhost -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 004 soju-test-user localhost soju aiwroO OovaimnqpsrtklbeI -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 005 * BOUNCER_NETID=1 CHATHISTORY=1000 MSGREFTYPES=timestamp CLIENTTAGDENY=* :are supported -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 221 soju-test-user + -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 422 soju-test-user :Use /motd to read the message of the day -2024/04/18 06:36:13 downstream "pipe": sent: :localhost PONG localhost roundtrip +2024/04/18 06:46:02 generating Web push VAPID key pair +2024/04/18 06:46:02 starting bouncer for user "soju-test-user" +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": connecting to plain-text server at address "127.0.0.1:36819" +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": new connection +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": sent: CAP LS 302 +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": sent: NICK soju-test-user +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": sent: USER soju-test-user 0 * soju-test-user +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": received: :soju-test-server 001 soju-test-user Welcome! +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": connection registered with nick "soju-test-user" +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": received: :soju-test-server 002 soju-test-user :Your host is soju-test-server +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": received: :soju-test-server 003 soju-test-user :Who cares when the server was created? +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": received: :soju-test-server 004 soju-test-user soju-test-server soju aiwroO OovaimnqpsrtklbeI +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": received: :soju-test-server 422 soju-test-user :No MOTD +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:00.000Z :foo PRIVMSG soju-test-user Hiya! +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:01.000Z :foo PRIVMSG soju-test-user :How are you doing? +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:02.000Z :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": received: PING roundtrip +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": sent: AWAY :Auto away +2024/04/18 06:46:02 user "soju-test-user": upstream "testnet": sent: PONG roundtrip +2024/04/18 06:46:02 downstream "pipe": new connection +2024/04/18 06:46:02 downstream "pipe": received: PASS soju-test-user +2024/04/18 06:46:02 downstream "pipe": received: NICK soju-test-user +2024/04/18 06:46:02 downstream "pipe": received: USER soju-test-user/testnet 0 * soju-test-user +2024/04/18 06:46:03 downstream "pipe": registration complete for user "soju-test-user" +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 001 soju-test-user :Welcome to soju, soju-test-user +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: PING roundtrip +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": sent: AWAY +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 002 soju-test-user :Your host is localhost +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 004 soju-test-user localhost soju aiwroO OovaimnqpsrtklbeI +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 005 * BOUNCER_NETID=1 CHATHISTORY=1000 MSGREFTYPES=timestamp CLIENTTAGDENY=* :are supported +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 221 soju-test-user + +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 422 soju-test-user :Use /motd to read the message of the day +2024/04/18 06:46:03 downstream "pipe": sent: :localhost PONG localhost roundtrip === RUN TestServer_chatHistory/fs/all -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T05:59:59.000Z 100 -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: PING roundtrip -2024/04/18 06:36:13 downstream "pipe": sent: :foo PRIVMSG soju-test-user Hiya! -2024/04/18 06:36:13 downstream "pipe": sent: :foo PRIVMSG soju-test-user :How are you doing? -2024/04/18 06:36:13 downstream "pipe": sent: :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? -2024/04/18 06:36:13 downstream "pipe": sent: :localhost PONG localhost roundtrip +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T05:59:59.000Z 100 +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: PING roundtrip +2024/04/18 06:46:03 downstream "pipe": sent: :foo PRIVMSG soju-test-user Hiya! +2024/04/18 06:46:03 downstream "pipe": sent: :foo PRIVMSG soju-test-user :How are you doing? +2024/04/18 06:46:03 downstream "pipe": sent: :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? +2024/04/18 06:46:03 downstream "pipe": sent: :localhost PONG localhost roundtrip === RUN TestServer_chatHistory/fs/none -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T06:00:02.000Z 100 -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: PING roundtrip -2024/04/18 06:36:13 downstream "pipe": sent: :localhost PONG localhost roundtrip +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T06:00:02.000Z 100 +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: PING roundtrip +2024/04/18 06:46:03 downstream "pipe": sent: :localhost PONG localhost roundtrip === RUN TestServer_chatHistory/fs/all_but_first -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T06:00:00.000Z 100 -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: PING roundtrip -2024/04/18 06:36:13 downstream "pipe": sent: :foo PRIVMSG soju-test-user :How are you doing? -2024/04/18 06:36:13 downstream "pipe": sent: :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? -2024/04/18 06:36:13 downstream "pipe": sent: :localhost PONG localhost roundtrip -2024/04/18 06:36:13 shutting down server -2024/04/18 06:36:13 waiting for users to finish -2024/04/18 06:36:13 downstream "pipe": connection closed -2024/04/18 06:36:13 user "soju-test-user": network "testnet": connection error to "irc+insecure://127.0.0.1:40369": failed to handle messages: failed to read IRC command: read tcp 127.0.0.1:50004->127.0.0.1:40369: read: connection reset by peer -2024/04/18 06:36:13 user "soju-test-user": network "testnet": waiting 1m57s before trying to reconnect to "irc+insecure://127.0.0.1:40369" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connection closed +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T06:00:00.000Z 100 +2024/04/18 06:46:03 downstream "pipe": sent: :foo PRIVMSG soju-test-user :How are you doing? +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: PING roundtrip +2024/04/18 06:46:03 downstream "pipe": sent: :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? +2024/04/18 06:46:03 downstream "pipe": sent: :localhost PONG localhost roundtrip +2024/04/18 06:46:03 user "soju-test-user": network "testnet": connection error to "irc+insecure://127.0.0.1:36819": failed to handle messages: failed to read IRC command: read tcp 127.0.0.1:36626->127.0.0.1:36819: read: connection reset by peer +2024/04/18 06:46:03 user "soju-test-user": network "testnet": waiting 1m47s before trying to reconnect to "irc+insecure://127.0.0.1:36819" +2024/04/18 06:46:03 downstream "pipe": sent: :BouncerServ!BouncerServ@BouncerServ NOTICE soju-test-user :disconnected from testnet +2024/04/18 06:46:03 downstream "pipe": failed to write message: io: read/write on closed pipe +2024/04/18 06:46:03 downstream "pipe": connection closed +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": connection closed +2024/04/18 06:46:03 shutting down server +2024/04/18 06:46:03 waiting for users to finish === RUN TestServer_chatHistory/db -2024/04/18 06:36:13 generating Web push VAPID key pair -2024/04/18 06:36:13 starting bouncer for user "soju-test-user" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connecting to plain-text server at address "127.0.0.1:36273" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": new connection -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: CAP LS 302 -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: NICK soju-test-user -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: USER soju-test-user 0 * soju-test-user -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 001 soju-test-user Welcome! -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connection registered with nick "soju-test-user" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 002 soju-test-user :Your host is soju-test-server -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 003 soju-test-user :Who cares when the server was created? -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 004 soju-test-user soju-test-server soju aiwroO OovaimnqpsrtklbeI -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: :soju-test-server 422 soju-test-user :No MOTD -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:00.000Z :foo PRIVMSG soju-test-user Hiya! -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:01.000Z :foo PRIVMSG soju-test-user :How are you doing? -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:02.000Z :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": received: PING roundtrip -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: AWAY :Auto away -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: PONG roundtrip -2024/04/18 06:36:13 downstream "pipe": new connection -2024/04/18 06:36:13 downstream "pipe": received: PASS soju-test-user -2024/04/18 06:36:13 downstream "pipe": received: NICK soju-test-user -2024/04/18 06:36:13 downstream "pipe": received: USER soju-test-user/testnet 0 * soju-test-user -2024/04/18 06:36:13 downstream "pipe": registration complete for user "soju-test-user" -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 001 soju-test-user :Welcome to soju, soju-test-user -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: PING roundtrip -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": sent: AWAY -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 002 soju-test-user :Your host is localhost -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 004 soju-test-user localhost soju aiwroO OovaimnqpsrtklbeI -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 005 * BOUNCER_NETID=1 CHATHISTORY=1000 MSGREFTYPES=timestamp CLIENTTAGDENY=* :are supported -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 221 soju-test-user + -2024/04/18 06:36:13 downstream "pipe": sent: :localhost 422 soju-test-user :Use /motd to read the message of the day -2024/04/18 06:36:13 downstream "pipe": sent: :localhost PONG localhost roundtrip +2024/04/18 06:46:03 generating Web push VAPID key pair +2024/04/18 06:46:03 starting bouncer for user "soju-test-user" +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": connecting to plain-text server at address "127.0.0.1:36357" +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": new connection +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": sent: CAP LS 302 +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": sent: NICK soju-test-user +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": sent: USER soju-test-user 0 * soju-test-user +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": received: :soju-test-server 001 soju-test-user Welcome! +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": connection registered with nick "soju-test-user" +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": received: :soju-test-server 002 soju-test-user :Your host is soju-test-server +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": received: :soju-test-server 003 soju-test-user :Who cares when the server was created? +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": received: :soju-test-server 004 soju-test-user soju-test-server soju aiwroO OovaimnqpsrtklbeI +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": received: :soju-test-server 422 soju-test-user :No MOTD +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:00.000Z :foo PRIVMSG soju-test-user Hiya! +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:01.000Z :foo PRIVMSG soju-test-user :How are you doing? +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": received: @time=2023-05-23T06:00:02.000Z :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": received: PING roundtrip +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": sent: AWAY :Auto away +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": sent: PONG roundtrip +2024/04/18 06:46:03 downstream "pipe": new connection +2024/04/18 06:46:03 downstream "pipe": received: PASS soju-test-user +2024/04/18 06:46:03 downstream "pipe": received: NICK soju-test-user +2024/04/18 06:46:03 downstream "pipe": received: USER soju-test-user/testnet 0 * soju-test-user +2024/04/18 06:46:03 downstream "pipe": registration complete for user "soju-test-user" +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 001 soju-test-user :Welcome to soju, soju-test-user +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: PING roundtrip +2024/04/18 06:46:03 user "soju-test-user": upstream "testnet": sent: AWAY +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 002 soju-test-user :Your host is localhost +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 004 soju-test-user localhost soju aiwroO OovaimnqpsrtklbeI +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 005 * BOUNCER_NETID=1 CHATHISTORY=1000 MSGREFTYPES=timestamp CLIENTTAGDENY=* :are supported +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 221 soju-test-user + +2024/04/18 06:46:03 downstream "pipe": sent: :localhost 422 soju-test-user :Use /motd to read the message of the day +2024/04/18 06:46:03 downstream "pipe": sent: :localhost PONG localhost roundtrip === RUN TestServer_chatHistory/db/all -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T05:59:59.000Z 100 -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: PING roundtrip -2024/04/18 06:36:13 downstream "pipe": sent: :foo PRIVMSG soju-test-user Hiya! -2024/04/18 06:36:13 downstream "pipe": sent: :foo PRIVMSG soju-test-user :How are you doing? -2024/04/18 06:36:13 downstream "pipe": sent: :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? -2024/04/18 06:36:13 downstream "pipe": sent: :localhost PONG localhost roundtrip +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T05:59:59.000Z 100 +2024/04/18 06:46:03 downstream "pipe": sent: :foo PRIVMSG soju-test-user Hiya! +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: PING roundtrip +2024/04/18 06:46:03 downstream "pipe": sent: :foo PRIVMSG soju-test-user :How are you doing? +2024/04/18 06:46:03 downstream "pipe": sent: :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? +2024/04/18 06:46:03 downstream "pipe": sent: :localhost PONG localhost roundtrip === RUN TestServer_chatHistory/db/none -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T06:00:02.000Z 100 -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: PING roundtrip -2024/04/18 06:36:13 downstream "pipe": sent: :localhost PONG localhost roundtrip +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T06:00:02.000Z 100 +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: PING roundtrip +2024/04/18 06:46:03 downstream "pipe": sent: :localhost PONG localhost roundtrip === RUN TestServer_chatHistory/db/all_but_first -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T06:00:00.000Z 100 -2024/04/18 06:36:13 user "soju-test-user": downstream "pipe": received: PING roundtrip -2024/04/18 06:36:13 downstream "pipe": sent: :foo PRIVMSG soju-test-user :How are you doing? -2024/04/18 06:36:13 downstream "pipe": sent: :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? -2024/04/18 06:36:13 downstream "pipe": sent: :localhost PONG localhost roundtrip -2024/04/18 06:36:13 downstream "pipe": connection closed -2024/04/18 06:36:13 shutting down server -2024/04/18 06:36:13 waiting for users to finish -2024/04/18 06:36:13 user "soju-test-user": network "testnet": connection error to "irc+insecure://127.0.0.1:36273": failed to handle messages: failed to read IRC command: read tcp 127.0.0.1:51692->127.0.0.1:36273: read: connection reset by peer -2024/04/18 06:36:13 user "soju-test-user": network "testnet": waiting 1m4s before trying to reconnect to "irc+insecure://127.0.0.1:36273" -2024/04/18 06:36:13 user "soju-test-user": upstream "testnet": connection closed ---- PASS: TestServer_chatHistory (0.57s) - --- PASS: TestServer_chatHistory/fs (0.29s) +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: CHATHISTORY AFTER foo timestamp=2023-05-23T06:00:00.000Z 100 +2024/04/18 06:46:03 downstream "pipe": sent: :foo PRIVMSG soju-test-user :How are you doing? +2024/04/18 06:46:03 user "soju-test-user": downstream "pipe": received: PING roundtrip +2024/04/18 06:46:03 downstream "pipe": sent: :foo PRIVMSG soju-test-user :Can I take a sip from your glass of soju? +2024/04/18 06:46:03 downstream "pipe": sent: :localhost PONG localhost roundtrip +2024/04/18 06:46:03 shutting down server +2024/04/18 06:46:03 waiting for users to finish +--- PASS: TestServer_chatHistory (1.07s) + --- PASS: TestServer_chatHistory/fs (0.66s) --- PASS: TestServer_chatHistory/fs/all (0.00s) - --- PASS: TestServer_chatHistory/fs/none (0.00s) + --- PASS: TestServer_chatHistory/fs/none (0.01s) --- PASS: TestServer_chatHistory/fs/all_but_first (0.00s) - --- PASS: TestServer_chatHistory/db (0.28s) + --- PASS: TestServer_chatHistory/db (0.41s) --- PASS: TestServer_chatHistory/db/all (0.00s) --- PASS: TestServer_chatHistory/db/none (0.00s) --- PASS: TestServer_chatHistory/db/all_but_first (0.00s) === RUN TestSplit --- PASS: TestSplit (0.00s) PASS -ok git.sr.ht/~emersion/soju 0.874s +ok git.sr.ht/~emersion/soju 1.996s ? git.sr.ht/~emersion/soju/auth [no test files] ? git.sr.ht/~emersion/soju/cmd/soju [no test files] ? git.sr.ht/~emersion/soju/cmd/sojuctl [no test files] @@ -1205,9 +1230,9 @@ postgres_test.go:73: set SOJU_TEST_POSTGRES to a connection string to execute PostgreSQL tests --- SKIP: TestPostgresMigrations (0.00s) === RUN TestSqliteMigrations ---- PASS: TestSqliteMigrations (0.03s) +--- PASS: TestSqliteMigrations (0.04s) PASS -ok git.sr.ht/~emersion/soju/database 0.045s +ok git.sr.ht/~emersion/soju/database 0.117s create-stamp debian/debhelper-build-stamp dh_testroot -O--builddirectory=_build -O--buildsystem=golang dh_prep -O--builddirectory=_build -O--buildsystem=golang @@ -1237,15 +1262,15 @@ dh_installdeb -O--builddirectory=_build -O--buildsystem=golang dh_golang -O--builddirectory=_build -O--buildsystem=golang dh_gencontrol -O--builddirectory=_build -O--buildsystem=golang -dpkg-gencontrol: warning: package soju-utils: substitution variable ${misc:Static-Built-Using} unused, but is defined dpkg-gencontrol: warning: package soju: substitution variable ${misc:Static-Built-Using} unused, but is defined dpkg-gencontrol: warning: package soju-utils: substitution variable ${misc:Static-Built-Using} unused, but is defined +dpkg-gencontrol: warning: package soju-utils: substitution variable ${misc:Static-Built-Using} unused, but is defined dpkg-gencontrol: warning: package soju: substitution variable ${misc:Static-Built-Using} unused, but is defined dh_md5sums -O--builddirectory=_build -O--buildsystem=golang dh_builddeb -O--builddirectory=_build -O--buildsystem=golang dpkg-deb: building package 'soju-utils' in '../soju-utils_0.7.0-1_armhf.deb'. -dpkg-deb: building package 'soju' in '../soju_0.7.0-1_armhf.deb'. dpkg-deb: building package 'soju-utils-dbgsym' in '../soju-utils-dbgsym_0.7.0-1_armhf.deb'. +dpkg-deb: building package 'soju' in '../soju_0.7.0-1_armhf.deb'. dpkg-deb: building package 'soju-dbgsym' in '../soju-dbgsym_0.7.0-1_armhf.deb'. dpkg-genbuildinfo --build=binary -O../soju_0.7.0-1_armhf.buildinfo dpkg-genchanges --build=binary -O../soju_0.7.0-1_armhf.changes @@ -1254,12 +1279,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/16002/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/16002/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/6881 and its subdirectories -I: Current time: Wed Apr 17 18:37:03 -12 2024 -I: pbuilder-time-stamp: 1713422223 +I: removing directory /srv/workspace/pbuilder/16002 and its subdirectories +I: Current time: Thu Apr 18 20:47:37 +14 2024 +I: pbuilder-time-stamp: 1713422857