Diff of the two buildlogs: -- --- b1/build.log 2024-04-28 00:40:00.514700215 +0000 +++ b2/build.log 2024-04-28 00:41:27.782977724 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Fri May 30 18:59:04 -12 2025 -I: pbuilder-time-stamp: 1748674744 +I: Current time: Sun Apr 28 14:40:03 +14 2024 +I: pbuilder-time-stamp: 1714264803 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/unstable-reproducible-base.tgz] I: copying local configuration @@ -27,52 +27,84 @@ dpkg-source: info: applying 01-remove-jaeger.patch I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/603206/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/4156631/tmp/hooks/D01_modify_environment starting +debug: Running on codethink02-arm64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Apr 28 00:40 /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/4156631/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/4156631/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='arm64' - DEBIAN_FRONTEND='noninteractive' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="21" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.2.21(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=arm64 + DEBIAN_FRONTEND=noninteractive DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=12 ' - DISTRIBUTION='unstable' - HOME='/root' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION=unstable + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - INVOCATION_ID='e5ef03c548aa4046a07f9094f954f5f1' - 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='603206' - PS1='# ' - PS2='> ' + INVOCATION_ID=30719c845f8249c38d408a5348c6f525 + LANG=C + LANGUAGE=nl_BE:nl + LC_ALL=C + MACHTYPE=aarch64-unknown-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=4156631 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.uf7V58Bm/pbuilderrc_hJVG --distribution unstable --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.uf7V58Bm/b1 --logfile b1/build.log mtail_3.0.0~rc54+git0ff5-1.dsc' - SUDO_GID='109' - SUDO_UID='104' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://192.168.101.4:3128' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.uf7V58Bm/pbuilderrc_4nwa --distribution unstable --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.uf7V58Bm/b2 --logfile b2/build.log mtail_3.0.0~rc54+git0ff5-1.dsc' + SUDO_GID=109 + SUDO_UID=104 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://192.168.101.4:3128 I: uname -a - Linux codethink03-arm64 6.1.0-20-cloud-arm64 #1 SMP Debian 6.1.85-1 (2024-04-11) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-20-cloud-arm64 #1 SMP Debian 6.1.85-1 (2024-04-11) aarch64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 May 30 14:05 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/603206/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Apr 27 07:42 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/4156631/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -216,7 +248,7 @@ Get: 81 http://deb.debian.org/debian unstable/main arm64 libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [326 kB] Get: 82 http://deb.debian.org/debian unstable/main arm64 libjs-jquery-ui all 1.13.2+dfsg-1 [250 kB] Get: 83 http://deb.debian.org/debian unstable/main arm64 golang-golang-x-tools arm64 1:0.20.0+ds-1 [35.4 MB] -Fetched 122 MB in 2s (49.0 MB/s) +Fetched 122 MB in 1s (229 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package tzdata. (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 ... 19738 files and directories currently installed.) @@ -493,8 +525,8 @@ Setting up tzdata (2024a-3) ... Current default time zone: 'Etc/UTC' -Local time is now: Sat May 31 07:00:04 UTC 2025. -Universal Time is now: Sat May 31 07:00:04 UTC 2025. +Local time is now: Sun Apr 28 00:40:24 UTC 2024. +Universal Time is now: Sun Apr 28 00:40:24 UTC 2024. Run 'dpkg-reconfigure tzdata' if you wish to change it. Setting up golang-github-cespare-xxhash-dev (2.1.1-2) ... @@ -569,7 +601,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/mtail-3.0.0~rc54+git0ff5/ && 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 > ../mtail_3.0.0~rc54+git0ff5-1_source.changes +I: user script /srv/workspace/pbuilder/4156631/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for unstable +I: user script /srv/workspace/pbuilder/4156631/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/mtail-3.0.0~rc54+git0ff5/ && 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 > ../mtail_3.0.0~rc54+git0ff5-1_source.changes dpkg-buildpackage: info: source package mtail dpkg-buildpackage: info: source version 3.0.0~rc54+git0ff5-1 dpkg-buildpackage: info: source distribution unstable @@ -723,30 +759,30 @@ src/github.com/google/mtail/internal/waker/testwaker_test.go src/github.com/google/mtail/internal/waker/timedwaker_test.go cd build && go install -trimpath -v -p 12 -ldflags " -X main.Version=3.0.0~rc54+git0ff5 -X main.Revision=3.0.0~rc54+git0ff5-1 -X main.Branch=Debian/unstable" github.com/google/mtail/cmd/mfmt github.com/google/mtail/cmd/mtail github.com/google/mtail/internal/exporter github.com/google/mtail/internal/logline github.com/google/mtail/internal/metrics github.com/google/mtail/internal/metrics/datum github.com/google/mtail/internal/mtail github.com/google/mtail/internal/mtail/golden github.com/google/mtail/internal/runtime github.com/google/mtail/internal/runtime/code github.com/google/mtail/internal/runtime/compiler github.com/google/mtail/internal/runtime/compiler/ast github.com/google/mtail/internal/runtime/compiler/checker github.com/google/mtail/internal/runtime/compiler/codegen github.com/google/mtail/internal/runtime/compiler/errors github.com/google/mtail/internal/runtime/compiler/opt github.com/google/mtail/internal/runtime/compiler/parser github.com/google/mtail/internal/runtime/compiler/position github.com/google/mtail/internal/runtime/compiler/symbol github.com/google/mtail/internal/runtime/compiler/types github.com/google/mtail/internal/runtime/vm github.com/google/mtail/internal/tailer github.com/google/mtail/internal/tailer/logstream github.com/google/mtail/internal/testutil github.com/google/mtail/internal/waker -internal/goos -unicode/utf8 -internal/goarch -internal/unsafeheader -internal/goexperiment internal/coverage/rtcov internal/godebugs encoding +internal/goarch +math/bits +unicode/utf8 +internal/unsafeheader +internal/goos internal/itoa +internal/goexperiment internal/race -internal/abi -internal/cpu -math/bits -internal/chacha8rand -runtime/internal/math +sync/atomic +math runtime/internal/syscall unicode +internal/cpu cmp log/internal +internal/abi +internal/chacha8rand +runtime/internal/math runtime/internal/sys -sync/atomic unicode/utf16 container/list -math slices crypto/internal/alias crypto/subtle @@ -757,12 +793,12 @@ google.golang.org/protobuf/internal/flags google.golang.org/protobuf/internal/set github.com/golang/groupcache/lru -internal/bytealg -runtime/internal/atomic github.com/google/go-cmp/cmp/internal/flags go.opencensus.io go.opencensus.io/internal/tagencoding go.opencensus.io/trace/internal +internal/bytealg +runtime/internal/atomic runtime internal/reflectlite sync @@ -778,30 +814,30 @@ strconv io internal/oserror -syscall -vendor/golang.org/x/net/dns/dnsmessage -path internal/safefilepath -internal/intern +path math/rand crypto/internal/nistec/fiat -text/tabwriter -bytes -crypto/internal/randutil +syscall strings +vendor/golang.org/x/net/dns/dnsmessage +internal/intern +bytes hash -github.com/beorn7/perks/quantile +text/tabwriter reflect -crypto/rc4 +github.com/beorn7/perks/quantile +crypto/internal/randutil hash/crc32 crypto +crypto/rc4 net/netip -hash/fnv +regexp/syntax +bufio github.com/golang/glog/internal/stackdump vendor/golang.org/x/text/transform -bufio -regexp/syntax net/http/internal/ascii +hash/fnv github.com/prometheus/common/internal/bitbucket.org/ww/goautoneg html regexp @@ -811,32 +847,32 @@ internal/fmtsort encoding/binary github.com/google/go-cmp/cmp/internal/function +internal/poll io/fs context github.com/google/go-cmp/cmp/internal/diff -internal/poll -embed -github.com/google/mtail/internal/logline -google.golang.org/protobuf/internal/editiondefaults encoding/base64 crypto/cipher crypto/internal/edwards25519/field -crypto/internal/nistec +embed crypto/md5 vendor/golang.org/x/crypto/internal/poly1305 github.com/cespare/xxhash golang.org/x/sys/unix -os +github.com/google/mtail/internal/logline encoding/pem +crypto/internal/nistec +google.golang.org/protobuf/internal/editiondefaults +os crypto/internal/boring -crypto/des vendor/golang.org/x/crypto/chacha20 +crypto/des crypto/aes +crypto/internal/edwards25519 crypto/sha512 +crypto/sha256 crypto/hmac crypto/sha1 -crypto/sha256 -crypto/internal/edwards25519 vendor/golang.org/x/crypto/hkdf vendor/golang.org/x/crypto/chacha20poly1305 crypto/ecdh @@ -854,110 +890,110 @@ log os/user compress/flate -encoding/json github.com/pkg/errors github.com/google/mtail/internal/runtime/compiler/position math/big +encoding/json encoding/hex net/url vendor/golang.org/x/text/unicode/norm github.com/google/mtail/internal/runtime/compiler/errors -vendor/golang.org/x/net/http2/hpack vendor/golang.org/x/text/unicode/bidi +vendor/golang.org/x/net/http2/hpack mime mime/quotedprintable net/http/internal google.golang.org/protobuf/internal/errors -compress/gzip go/token -google.golang.org/protobuf/internal/version google.golang.org/protobuf/encoding/protowire +compress/gzip +google.golang.org/protobuf/internal/version github.com/prometheus/procfs/internal/fs -runtime/debug -text/template/parse -vendor/golang.org/x/text/secure/bidirule google.golang.org/protobuf/reflect/protoreflect runtime/pprof +text/template/parse +runtime/debug github.com/google/go-cmp/cmp/internal/value +vendor/golang.org/x/text/secure/bidirule runtime/trace database/sql/driver -testing github.com/google/go-cmp/cmp -database/sql go.opencensus.io/internal +testing go.opencensus.io/resource -text/template -go.opencensus.io/metric/metricdata github.com/google/mtail/internal/metrics/datum +database/sql +go.opencensus.io/metric/metricdata +go.opencensus.io/trace/tracestate +go.opencensus.io/metric/metricproducer google.golang.org/protobuf/internal/descfmt -google.golang.org/protobuf/internal/descopts vendor/golang.org/x/net/idna +google.golang.org/protobuf/internal/descopts google.golang.org/protobuf/internal/strs google.golang.org/protobuf/internal/encoding/messageset -crypto/rand -crypto/elliptic -crypto/internal/bigmod -crypto/internal/boring/bbig -encoding/asn1 -crypto/dsa -crypto/ed25519 -google.golang.org/protobuf/internal/encoding/text google.golang.org/protobuf/internal/genid -crypto/rsa google.golang.org/protobuf/internal/order google.golang.org/protobuf/reflect/protoregistry +google.golang.org/protobuf/internal/encoding/text google.golang.org/protobuf/runtime/protoiface +text/template go.opencensus.io/tag -go.opencensus.io/metric/metricproducer -go.opencensus.io/trace/tracestate google.golang.org/grpc/codes -google.golang.org/grpc/internal/grpclog -google.golang.org/grpc/metadata -go.opencensus.io/trace +crypto/rand +crypto/elliptic +crypto/internal/bigmod +crypto/internal/boring/bbig +encoding/asn1 +crypto/ed25519 +crypto/dsa google.golang.org/protobuf/internal/encoding/defval -vendor/golang.org/x/crypto/cryptobyte -crypto/x509/pkix -google.golang.org/grpc/grpclog google.golang.org/protobuf/proto go.opencensus.io/stats/internal -github.com/golang/protobuf/proto -html/template -github.com/prometheus/common/version +go.opencensus.io/trace go.opencensus.io/stats +google.golang.org/grpc/internal/grpclog +google.golang.org/grpc/metadata +github.com/golang/protobuf/proto +crypto/rsa internal/profile +google.golang.org/grpc/grpclog go.opencensus.io/stats/view +vendor/golang.org/x/crypto/cryptobyte +crypto/x509/pkix github.com/google/go-cmp/cmp/cmpopts -crypto/ecdsa +html/template +github.com/prometheus/common/version google.golang.org/protobuf/internal/filedesc google.golang.org/protobuf/encoding/protodelim google.golang.org/protobuf/encoding/prototext +crypto/ecdsa github.com/golang/glog github.com/google/mtail/internal/metrics github.com/google/mtail/internal/runtime/compiler/types github.com/google/mtail/internal/waker -github.com/google/mtail/internal/runtime/compiler/symbol github.com/google/mtail/internal/runtime/code -github.com/google/mtail/internal/runtime/compiler/ast github.com/google/mtail/internal/mtail/golden -github.com/google/mtail/internal/runtime/compiler/parser +github.com/google/mtail/internal/runtime/compiler/symbol +github.com/google/mtail/internal/runtime/compiler/ast google.golang.org/protobuf/internal/encoding/tag google.golang.org/protobuf/internal/impl +github.com/google/mtail/internal/runtime/compiler/parser github.com/golang/protobuf/ptypes/any github.com/golang/protobuf/ptypes/duration github.com/golang/protobuf/ptypes/timestamp google.golang.org/genproto/googleapis/rpc/status -github.com/google/mtail/internal/runtime/compiler/checker -github.com/google/mtail/internal/runtime/compiler/opt -github.com/google/mtail/internal/runtime/compiler/codegen github.com/golang/protobuf/ptypes google.golang.org/grpc/internal/status google.golang.org/grpc/status +github.com/google/mtail/internal/runtime/compiler/checker +github.com/google/mtail/internal/runtime/compiler/codegen +github.com/google/mtail/internal/runtime/compiler/opt github.com/google/mtail/cmd/mfmt github.com/google/mtail/internal/runtime/compiler crypto/x509 -github.com/prometheus/procfs net/textproto vendor/golang.org/x/net/http/httpproxy +github.com/prometheus/procfs google.golang.org/grpc/stats vendor/golang.org/x/net/http/httpguts mime/multipart @@ -965,8 +1001,8 @@ google.golang.org/protobuf/runtime/protoimpl google.golang.org/protobuf/types/known/timestamppb github.com/prometheus/client_model/go -crypto/tls github.com/prometheus/common/model +crypto/tls github.com/prometheus/client_golang/prometheus/internal net/http/httptrace net/http @@ -979,12 +1015,12 @@ github.com/google/mtail/internal/tailer/logstream github.com/google/mtail/internal/testutil go.opencensus.io/zpages -github.com/google/mtail/internal/tailer github.com/prometheus/client_golang/prometheus +github.com/google/mtail/internal/tailer github.com/google/mtail/internal/exporter github.com/google/mtail/internal/runtime/vm -github.com/prometheus/client_golang/prometheus/collectors github.com/prometheus/client_golang/prometheus/collectors/version +github.com/prometheus/client_golang/prometheus/collectors github.com/prometheus/client_golang/prometheus/promhttp github.com/google/mtail/internal/runtime github.com/google/mtail/internal/mtail @@ -1068,7 +1104,7 @@ --- PASS: TestHandleVarz/dimensioned (0.00s) --- PASS: TestHandleVarz/text (0.00s) PASS -ok github.com/google/mtail/internal/exporter 0.057s +ok github.com/google/mtail/internal/exporter 0.044s === RUN TestKindType --- PASS: TestKindType (0.00s) === RUN TestScalarMetric @@ -1086,7 +1122,7 @@ === RUN TestAppendLabelValue --- PASS: TestAppendLabelValue (0.00s) === RUN TestMetricJSONRoundTrip ---- PASS: TestMetricJSONRoundTrip (0.11s) +--- PASS: TestMetricJSONRoundTrip (0.04s) === RUN TestTimer --- PASS: TestTimer (0.00s) === RUN TestRemoveMetricLabelValue @@ -1106,7 +1142,7 @@ === RUN TestExpireManyMetrics --- PASS: TestExpireManyMetrics (0.00s) PASS -ok github.com/google/mtail/internal/metrics 0.166s +ok github.com/google/mtail/internal/metrics 0.060s === RUN TestDatumSetAndValue --- PASS: TestDatumSetAndValue (0.00s) === RUN TestMarshalJSON @@ -1118,14 +1154,14 @@ === RUN TestMakeBucket --- PASS: TestMakeBucket (0.00s) PASS -ok github.com/google/mtail/internal/metrics/datum 0.086s +ok github.com/google/mtail/internal/metrics/datum 0.029s ? github.com/google/mtail/internal/runtime/compiler/position [no test files] === RUN TestBuildInfo --- PASS: TestBuildInfo (0.00s) === RUN TestBasicTail --- PASS: TestBasicTail (0.02s) === RUN TestNewLogDoesNotMatchIsIgnored ---- PASS: TestNewLogDoesNotMatchIsIgnored (0.04s) +--- PASS: TestNewLogDoesNotMatchIsIgnored (0.01s) === RUN TestBadProgramFailsCompilation --- PASS: TestBadProgramFailsCompilation (0.00s) === RUN TestExamplePrograms @@ -1140,18 +1176,18 @@ === RUN TestExamplePrograms/examples/vsftpd.mtail_on_testdata/vsftpd_xferlog === RUN TestExamplePrograms/examples/lighttpd.mtail_on_testdata/lighttpd_access.log === RUN TestExamplePrograms/examples/mysql_slowqueries.mtail_on_testdata/mysql_slowqueries.log ---- PASS: TestExamplePrograms (4.74s) - --- PASS: TestExamplePrograms/examples/rsyncd.mtail_on_testdata/rsyncd.log (0.03s) - --- PASS: TestExamplePrograms/examples/sftp.mtail_on_testdata/sftp_chroot.log (0.07s) - --- PASS: TestExamplePrograms/examples/dhcpd.mtail_on_testdata/anonymised_dhcpd_log (4.38s) - --- PASS: TestExamplePrograms/examples/ntpd.mtail_on_testdata/ntp4 (0.03s) - --- PASS: TestExamplePrograms/examples/ntpd_peerstats.mtail_on_testdata/xntp3_peerstats (0.01s) - --- PASS: TestExamplePrograms/examples/apache_combined.mtail_on_testdata/apache-combined.log (0.01s) - --- PASS: TestExamplePrograms/examples/apache_common.mtail_on_testdata/apache-common.log (0.03s) - --- PASS: TestExamplePrograms/examples/vsftpd.mtail_on_testdata/vsftpd_log (0.04s) - --- PASS: TestExamplePrograms/examples/vsftpd.mtail_on_testdata/vsftpd_xferlog (0.04s) - --- PASS: TestExamplePrograms/examples/lighttpd.mtail_on_testdata/lighttpd_access.log (0.02s) - --- PASS: TestExamplePrograms/examples/mysql_slowqueries.mtail_on_testdata/mysql_slowqueries.log (0.07s) +--- PASS: TestExamplePrograms (2.00s) + --- PASS: TestExamplePrograms/examples/rsyncd.mtail_on_testdata/rsyncd.log (0.02s) + --- PASS: TestExamplePrograms/examples/sftp.mtail_on_testdata/sftp_chroot.log (0.03s) + --- PASS: TestExamplePrograms/examples/dhcpd.mtail_on_testdata/anonymised_dhcpd_log (1.80s) + --- PASS: TestExamplePrograms/examples/ntpd.mtail_on_testdata/ntp4 (0.02s) + --- PASS: TestExamplePrograms/examples/ntpd_peerstats.mtail_on_testdata/xntp3_peerstats (0.02s) + --- PASS: TestExamplePrograms/examples/apache_combined.mtail_on_testdata/apache-combined.log (0.00s) + --- PASS: TestExamplePrograms/examples/apache_common.mtail_on_testdata/apache-common.log (0.01s) + --- PASS: TestExamplePrograms/examples/vsftpd.mtail_on_testdata/vsftpd_log (0.03s) + --- PASS: TestExamplePrograms/examples/vsftpd.mtail_on_testdata/vsftpd_xferlog (0.02s) + --- PASS: TestExamplePrograms/examples/lighttpd.mtail_on_testdata/lighttpd_access.log (0.01s) + --- PASS: TestExamplePrograms/examples/mysql_slowqueries.mtail_on_testdata/mysql_slowqueries.log (0.03s) === RUN TestCompileExamplePrograms === RUN TestCompileExamplePrograms/apache_combined.mtail === RUN TestCompileExamplePrograms/apache_common.mtail @@ -1170,23 +1206,23 @@ === RUN TestCompileExamplePrograms/sftp.mtail === RUN TestCompileExamplePrograms/timer.mtail === RUN TestCompileExamplePrograms/vsftpd.mtail ---- PASS: TestCompileExamplePrograms (0.24s) +--- PASS: TestCompileExamplePrograms (0.18s) --- PASS: TestCompileExamplePrograms/apache_combined.mtail (0.00s) - --- PASS: TestCompileExamplePrograms/apache_common.mtail (0.02s) + --- PASS: TestCompileExamplePrograms/apache_common.mtail (0.01s) --- PASS: TestCompileExamplePrograms/apache_metrics.mtail (0.01s) - --- PASS: TestCompileExamplePrograms/dhcpd.mtail (0.04s) + --- PASS: TestCompileExamplePrograms/dhcpd.mtail (0.02s) --- PASS: TestCompileExamplePrograms/histogram.mtail (0.00s) - --- PASS: TestCompileExamplePrograms/lighttpd.mtail (0.02s) - --- PASS: TestCompileExamplePrograms/linecount.mtail (0.00s) - --- PASS: TestCompileExamplePrograms/mysql_slowqueries.mtail (0.03s) - --- PASS: TestCompileExamplePrograms/nocode.mtail (0.01s) + --- PASS: TestCompileExamplePrograms/lighttpd.mtail (0.00s) + --- PASS: TestCompileExamplePrograms/linecount.mtail (0.01s) + --- PASS: TestCompileExamplePrograms/mysql_slowqueries.mtail (0.02s) + --- PASS: TestCompileExamplePrograms/nocode.mtail (0.00s) --- PASS: TestCompileExamplePrograms/ntpd.mtail (0.01s) --- PASS: TestCompileExamplePrograms/ntpd_peerstats.mtail (0.01s) - --- PASS: TestCompileExamplePrograms/postfix.mtail (0.04s) - --- PASS: TestCompileExamplePrograms/rails.mtail (0.00s) - --- PASS: TestCompileExamplePrograms/rsyncd.mtail (0.01s) + --- PASS: TestCompileExamplePrograms/postfix.mtail (0.03s) + --- PASS: TestCompileExamplePrograms/rails.mtail (0.01s) + --- PASS: TestCompileExamplePrograms/rsyncd.mtail (0.00s) --- PASS: TestCompileExamplePrograms/sftp.mtail (0.02s) - --- PASS: TestCompileExamplePrograms/timer.mtail (0.00s) + --- PASS: TestCompileExamplePrograms/timer.mtail (0.01s) --- PASS: TestCompileExamplePrograms/vsftpd.mtail (0.02s) === RUN TestFilePipeStreamComparison === RUN TestFilePipeStreamComparison/examples/rsyncd.mtail_on_testdata/rsyncd.log @@ -1200,18 +1236,18 @@ === RUN TestFilePipeStreamComparison/examples/vsftpd.mtail_on_testdata/vsftpd_xferlog === RUN TestFilePipeStreamComparison/examples/lighttpd.mtail_on_testdata/lighttpd_access.log === RUN TestFilePipeStreamComparison/examples/mysql_slowqueries.mtail_on_testdata/mysql_slowqueries.log ---- PASS: TestFilePipeStreamComparison (5.35s) +--- PASS: TestFilePipeStreamComparison (2.25s) --- PASS: TestFilePipeStreamComparison/examples/rsyncd.mtail_on_testdata/rsyncd.log (0.02s) --- PASS: TestFilePipeStreamComparison/examples/sftp.mtail_on_testdata/sftp_chroot.log (0.02s) - --- PASS: TestFilePipeStreamComparison/examples/dhcpd.mtail_on_testdata/anonymised_dhcpd_log (5.02s) - --- PASS: TestFilePipeStreamComparison/examples/ntpd.mtail_on_testdata/ntp4 (0.03s) - --- PASS: TestFilePipeStreamComparison/examples/ntpd_peerstats.mtail_on_testdata/xntp3_peerstats (0.02s) - --- PASS: TestFilePipeStreamComparison/examples/apache_combined.mtail_on_testdata/apache-combined.log (0.02s) - --- PASS: TestFilePipeStreamComparison/examples/apache_common.mtail_on_testdata/apache-common.log (0.02s) - --- PASS: TestFilePipeStreamComparison/examples/vsftpd.mtail_on_testdata/vsftpd_log (0.06s) - --- PASS: TestFilePipeStreamComparison/examples/vsftpd.mtail_on_testdata/vsftpd_xferlog (0.03s) - --- PASS: TestFilePipeStreamComparison/examples/lighttpd.mtail_on_testdata/lighttpd_access.log (0.03s) - --- PASS: TestFilePipeStreamComparison/examples/mysql_slowqueries.mtail_on_testdata/mysql_slowqueries.log (0.07s) + --- PASS: TestFilePipeStreamComparison/examples/dhcpd.mtail_on_testdata/anonymised_dhcpd_log (2.08s) + --- PASS: TestFilePipeStreamComparison/examples/ntpd.mtail_on_testdata/ntp4 (0.02s) + --- PASS: TestFilePipeStreamComparison/examples/ntpd_peerstats.mtail_on_testdata/xntp3_peerstats (0.01s) + --- PASS: TestFilePipeStreamComparison/examples/apache_combined.mtail_on_testdata/apache-combined.log (0.01s) + --- PASS: TestFilePipeStreamComparison/examples/apache_common.mtail_on_testdata/apache-common.log (0.01s) + --- PASS: TestFilePipeStreamComparison/examples/vsftpd.mtail_on_testdata/vsftpd_log (0.02s) + --- PASS: TestFilePipeStreamComparison/examples/vsftpd.mtail_on_testdata/vsftpd_xferlog (0.02s) + --- PASS: TestFilePipeStreamComparison/examples/lighttpd.mtail_on_testdata/lighttpd_access.log (0.01s) + --- PASS: TestFilePipeStreamComparison/examples/mysql_slowqueries.mtail_on_testdata/mysql_slowqueries.log (0.02s) === RUN TestFileSocketStreamComparison === RUN TestFileSocketStreamComparison/examples/rsyncd.mtail_on_unixgram://testdata/rsyncd.log === RUN TestFileSocketStreamComparison/examples/sftp.mtail_on_unixgram://testdata/sftp_chroot.log @@ -1235,29 +1271,29 @@ === RUN TestFileSocketStreamComparison/examples/vsftpd.mtail_on_unix://testdata/vsftpd_xferlog === RUN TestFileSocketStreamComparison/examples/lighttpd.mtail_on_unix://testdata/lighttpd_access.log === RUN TestFileSocketStreamComparison/examples/mysql_slowqueries.mtail_on_unix://testdata/mysql_slowqueries.log ---- PASS: TestFileSocketStreamComparison (10.53s) - --- PASS: TestFileSocketStreamComparison/examples/rsyncd.mtail_on_unixgram://testdata/rsyncd.log (0.07s) - --- PASS: TestFileSocketStreamComparison/examples/sftp.mtail_on_unixgram://testdata/sftp_chroot.log (0.05s) - --- PASS: TestFileSocketStreamComparison/examples/dhcpd.mtail_on_unixgram://testdata/anonymised_dhcpd_log (5.41s) - --- PASS: TestFileSocketStreamComparison/examples/ntpd.mtail_on_unixgram://testdata/ntp4 (0.03s) - --- PASS: TestFileSocketStreamComparison/examples/ntpd_peerstats.mtail_on_unixgram://testdata/xntp3_peerstats (0.04s) - --- PASS: TestFileSocketStreamComparison/examples/apache_combined.mtail_on_unixgram://testdata/apache-combined.log (0.03s) - --- PASS: TestFileSocketStreamComparison/examples/apache_common.mtail_on_unixgram://testdata/apache-common.log (0.06s) - --- PASS: TestFileSocketStreamComparison/examples/vsftpd.mtail_on_unixgram://testdata/vsftpd_log (0.07s) - --- PASS: TestFileSocketStreamComparison/examples/vsftpd.mtail_on_unixgram://testdata/vsftpd_xferlog (0.03s) - --- PASS: TestFileSocketStreamComparison/examples/lighttpd.mtail_on_unixgram://testdata/lighttpd_access.log (0.04s) - --- PASS: TestFileSocketStreamComparison/examples/mysql_slowqueries.mtail_on_unixgram://testdata/mysql_slowqueries.log (0.06s) - --- PASS: TestFileSocketStreamComparison/examples/rsyncd.mtail_on_unix://testdata/rsyncd.log (0.06s) - --- PASS: TestFileSocketStreamComparison/examples/sftp.mtail_on_unix://testdata/sftp_chroot.log (0.03s) - --- PASS: TestFileSocketStreamComparison/examples/dhcpd.mtail_on_unix://testdata/anonymised_dhcpd_log (4.26s) - --- PASS: TestFileSocketStreamComparison/examples/ntpd.mtail_on_unix://testdata/ntp4 (0.03s) +--- PASS: TestFileSocketStreamComparison (4.67s) + --- PASS: TestFileSocketStreamComparison/examples/rsyncd.mtail_on_unixgram://testdata/rsyncd.log (0.03s) + --- PASS: TestFileSocketStreamComparison/examples/sftp.mtail_on_unixgram://testdata/sftp_chroot.log (0.02s) + --- PASS: TestFileSocketStreamComparison/examples/dhcpd.mtail_on_unixgram://testdata/anonymised_dhcpd_log (2.08s) + --- PASS: TestFileSocketStreamComparison/examples/ntpd.mtail_on_unixgram://testdata/ntp4 (0.01s) + --- PASS: TestFileSocketStreamComparison/examples/ntpd_peerstats.mtail_on_unixgram://testdata/xntp3_peerstats (0.02s) + --- PASS: TestFileSocketStreamComparison/examples/apache_combined.mtail_on_unixgram://testdata/apache-combined.log (0.01s) + --- PASS: TestFileSocketStreamComparison/examples/apache_common.mtail_on_unixgram://testdata/apache-common.log (0.01s) + --- PASS: TestFileSocketStreamComparison/examples/vsftpd.mtail_on_unixgram://testdata/vsftpd_log (0.03s) + --- PASS: TestFileSocketStreamComparison/examples/vsftpd.mtail_on_unixgram://testdata/vsftpd_xferlog (0.02s) + --- PASS: TestFileSocketStreamComparison/examples/lighttpd.mtail_on_unixgram://testdata/lighttpd_access.log (0.01s) + --- PASS: TestFileSocketStreamComparison/examples/mysql_slowqueries.mtail_on_unixgram://testdata/mysql_slowqueries.log (0.05s) + --- PASS: TestFileSocketStreamComparison/examples/rsyncd.mtail_on_unix://testdata/rsyncd.log (0.03s) + --- PASS: TestFileSocketStreamComparison/examples/sftp.mtail_on_unix://testdata/sftp_chroot.log (0.02s) + --- PASS: TestFileSocketStreamComparison/examples/dhcpd.mtail_on_unix://testdata/anonymised_dhcpd_log (2.19s) + --- PASS: TestFileSocketStreamComparison/examples/ntpd.mtail_on_unix://testdata/ntp4 (0.02s) --- PASS: TestFileSocketStreamComparison/examples/ntpd_peerstats.mtail_on_unix://testdata/xntp3_peerstats (0.02s) - --- PASS: TestFileSocketStreamComparison/examples/apache_combined.mtail_on_unix://testdata/apache-combined.log (0.01s) - --- PASS: TestFileSocketStreamComparison/examples/apache_common.mtail_on_unix://testdata/apache-common.log (0.03s) - --- PASS: TestFileSocketStreamComparison/examples/vsftpd.mtail_on_unix://testdata/vsftpd_log (0.06s) - --- PASS: TestFileSocketStreamComparison/examples/vsftpd.mtail_on_unix://testdata/vsftpd_xferlog (0.03s) - --- PASS: TestFileSocketStreamComparison/examples/lighttpd.mtail_on_unix://testdata/lighttpd_access.log (0.02s) - --- PASS: TestFileSocketStreamComparison/examples/mysql_slowqueries.mtail_on_unix://testdata/mysql_slowqueries.log (0.07s) + --- PASS: TestFileSocketStreamComparison/examples/apache_combined.mtail_on_unix://testdata/apache-combined.log (0.02s) + --- PASS: TestFileSocketStreamComparison/examples/apache_common.mtail_on_unix://testdata/apache-common.log (0.02s) + --- PASS: TestFileSocketStreamComparison/examples/vsftpd.mtail_on_unix://testdata/vsftpd_log (0.03s) + --- PASS: TestFileSocketStreamComparison/examples/vsftpd.mtail_on_unix://testdata/vsftpd_xferlog (0.02s) + --- PASS: TestFileSocketStreamComparison/examples/lighttpd.mtail_on_unix://testdata/lighttpd_access.log (0.01s) + --- PASS: TestFileSocketStreamComparison/examples/mysql_slowqueries.mtail_on_unix://testdata/mysql_slowqueries.log (0.03s) === RUN TestExecMtail exec_integration_test.go:32: mtail binary not found, skipping exec_integration_test.go:33: @@ -1273,7 +1309,7 @@ === RUN TestFilenameRegexIgnore --- PASS: TestFilenameRegexIgnore (0.00s) === RUN TestGlobRelativeAfterStart ---- PASS: TestGlobRelativeAfterStart (0.04s) +--- PASS: TestGlobRelativeAfterStart (0.03s) === RUN TestLogSoftLinkChange === RUN TestLogSoftLinkChange/race_simulation_disabled === RUN TestLogSoftLinkChange/race_simulation_enabled @@ -1291,9 +1327,9 @@ === RUN TestPollLogPathPatterns --- PASS: TestPollLogPathPatterns (0.02s) === RUN TestMultipleLinesInOneWrite ---- PASS: TestMultipleLinesInOneWrite (0.02s) +--- PASS: TestMultipleLinesInOneWrite (0.03s) === RUN TestPartialLineRead ---- PASS: TestPartialLineRead (0.01s) +--- PASS: TestPartialLineRead (0.02s) === RUN TestPermissionDeniedOnLog --- PASS: TestPermissionDeniedOnLog (0.01s) === RUN TestNewProg @@ -1301,25 +1337,25 @@ === RUN TestProgramReloadNoDuplicateMetrics --- PASS: TestProgramReloadNoDuplicateMetrics (0.05s) === RUN TestProgramUnloadIfDeleted ---- PASS: TestProgramUnloadIfDeleted (0.03s) +--- PASS: TestProgramUnloadIfDeleted (0.02s) === RUN TestReadFromPipe --- PASS: TestReadFromPipe (0.01s) === RUN TestReadFromSocket === RUN TestReadFromSocket/unix === RUN TestReadFromSocket/unixgram ---- PASS: TestReadFromSocket (0.06s) - --- PASS: TestReadFromSocket/unix (0.03s) - --- PASS: TestReadFromSocket/unixgram (0.03s) +--- PASS: TestReadFromSocket (0.05s) + --- PASS: TestReadFromSocket/unix (0.02s) + --- PASS: TestReadFromSocket/unixgram (0.02s) === RUN TestRelativeLog --- PASS: TestRelativeLog (0.01s) === RUN TestBasicUNIXSockets --- PASS: TestBasicUNIXSockets (0.00s) PASS -ok github.com/google/mtail/internal/mtail 21.506s +ok github.com/google/mtail/internal/mtail 9.594s === RUN TestReadTestData ---- PASS: TestReadTestData (0.04s) +--- PASS: TestReadTestData (0.01s) PASS -ok github.com/google/mtail/internal/mtail/golden 0.121s +ok github.com/google/mtail/internal/mtail/golden 0.050s === RUN TestRuntimeEndToEnd === RUN TestRuntimeEndToEnd/single-dash-parseint === RUN TestRuntimeEndToEnd/histogram @@ -1343,29 +1379,29 @@ === RUN TestRuntimeEndToEnd/subst_integer === RUN TestRuntimeEndToEnd/regexp_replace === RUN TestRuntimeEndToEnd/match_a_pattern_in_a_binary_expr ---- PASS: TestRuntimeEndToEnd (0.58s) - --- PASS: TestRuntimeEndToEnd/single-dash-parseint (0.04s) +--- PASS: TestRuntimeEndToEnd (0.36s) + --- PASS: TestRuntimeEndToEnd/single-dash-parseint (0.01s) --- PASS: TestRuntimeEndToEnd/histogram (0.02s) - --- PASS: TestRuntimeEndToEnd/numbers (0.03s) - --- PASS: TestRuntimeEndToEnd/parse_a_hyphen (0.03s) + --- PASS: TestRuntimeEndToEnd/numbers (0.01s) + --- PASS: TestRuntimeEndToEnd/parse_a_hyphen (0.02s) --- PASS: TestRuntimeEndToEnd/parse_around_a_hyphen (0.01s) --- PASS: TestRuntimeEndToEnd/add_assign_float (0.02s) - --- PASS: TestRuntimeEndToEnd/decorator (0.03s) + --- PASS: TestRuntimeEndToEnd/decorator (0.02s) --- PASS: TestRuntimeEndToEnd/else (0.02s) - --- PASS: TestRuntimeEndToEnd/otherwise (0.05s) - --- PASS: TestRuntimeEndToEnd/types (0.03s) - --- PASS: TestRuntimeEndToEnd/filename (0.02s) + --- PASS: TestRuntimeEndToEnd/otherwise (0.02s) + --- PASS: TestRuntimeEndToEnd/types (0.02s) + --- PASS: TestRuntimeEndToEnd/filename (0.01s) --- PASS: TestRuntimeEndToEnd/logical_operators (0.02s) --- PASS: TestRuntimeEndToEnd/strcat (0.02s) - --- PASS: TestRuntimeEndToEnd/typed-comparison (0.07s) - --- PASS: TestRuntimeEndToEnd/match-expression (0.03s) + --- PASS: TestRuntimeEndToEnd/typed-comparison (0.02s) + --- PASS: TestRuntimeEndToEnd/match-expression (0.02s) --- PASS: TestRuntimeEndToEnd/metric-as-rvalue (0.02s) --- PASS: TestRuntimeEndToEnd/stringy (0.02s) - --- PASS: TestRuntimeEndToEnd/ip-addr (0.02s) - --- PASS: TestRuntimeEndToEnd/subst_timestamp (0.04s) + --- PASS: TestRuntimeEndToEnd/ip-addr (0.01s) + --- PASS: TestRuntimeEndToEnd/subst_timestamp (0.01s) --- PASS: TestRuntimeEndToEnd/subst_integer (0.02s) - --- PASS: TestRuntimeEndToEnd/regexp_replace (0.02s) - --- PASS: TestRuntimeEndToEnd/match_a_pattern_in_a_binary_expr (0.02s) + --- PASS: TestRuntimeEndToEnd/regexp_replace (0.01s) + --- PASS: TestRuntimeEndToEnd/match_a_pattern_in_a_binary_expr (0.01s) === RUN TestNewRuntime --- PASS: TestNewRuntime (0.00s) === RUN TestNewRuntimeErrors @@ -1373,15 +1409,15 @@ === RUN TestCompileAndRun --- PASS: TestCompileAndRun (0.00s) === RUN TestLoadProg ---- PASS: TestLoadProg (0.01s) +--- PASS: TestLoadProg (0.00s) PASS -ok github.com/google/mtail/internal/runtime 0.733s +ok github.com/google/mtail/internal/runtime 0.421s === RUN TestOpcodeHasString --- PASS: TestOpcodeHasString (0.00s) === RUN TestInstrString --- PASS: TestInstrString (0.00s) PASS -ok github.com/google/mtail/internal/runtime/code 0.104s +ok github.com/google/mtail/internal/runtime/code 0.048s === RUN TestCompileParserError --- PASS: TestCompileParserError (0.00s) === RUN TestCompileCheckerError @@ -1389,13 +1425,13 @@ === RUN TestCompileCodegen --- PASS: TestCompileCodegen (0.00s) PASS -ok github.com/google/mtail/internal/runtime/compiler 0.108s +ok github.com/google/mtail/internal/runtime/compiler 0.036s === RUN TestWalkPanicsOnUnknown --- PASS: TestWalkPanicsOnUnknown (0.00s) === RUN TestAstReplacement --- PASS: TestAstReplacement (0.00s) PASS -ok github.com/google/mtail/internal/runtime/compiler/ast 0.112s +ok github.com/google/mtail/internal/runtime/compiler/ast 0.052s === RUN TestCheckInvalidPrograms === RUN TestCheckInvalidPrograms/undefined_named_capture_group === RUN TestCheckInvalidPrograms/out_of_bounds_capref @@ -1432,8 +1468,8 @@ === RUN TestCheckInvalidPrograms/dec_non_var === RUN TestCheckInvalidPrograms/cmp_to_None === RUN TestCheckInvalidPrograms/negate_None ---- PASS: TestCheckInvalidPrograms (0.04s) - --- PASS: TestCheckInvalidPrograms/undefined_named_capture_group (0.03s) +--- PASS: TestCheckInvalidPrograms (0.01s) + --- PASS: TestCheckInvalidPrograms/undefined_named_capture_group (0.00s) --- PASS: TestCheckInvalidPrograms/out_of_bounds_capref (0.00s) --- PASS: TestCheckInvalidPrograms/undefined_decorator (0.00s) --- PASS: TestCheckInvalidPrograms/undefined_identifier (0.00s) @@ -1501,7 +1537,7 @@ === RUN TestCheckValidPrograms/negative_numbers_in_capture_groups === RUN TestCheckValidPrograms/substitution === RUN TestCheckValidPrograms/regexp_subst ---- PASS: TestCheckValidPrograms (0.02s) +--- PASS: TestCheckValidPrograms (0.00s) --- PASS: TestCheckValidPrograms/capture_group (0.00s) --- PASS: TestCheckValidPrograms/shadowed_positionals (0.00s) --- PASS: TestCheckValidPrograms/sibling_positionals (0.00s) @@ -1543,7 +1579,7 @@ --- PASS: TestCheckTypeExpressions/Int_+_Float_->_Float (0.00s) --- PASS: TestCheckTypeExpressions/⍺_+_Float_->_Float (0.00s) PASS -ok github.com/google/mtail/internal/runtime/compiler/checker 0.173s +ok github.com/google/mtail/internal/runtime/compiler/checker 0.039s === RUN TestCodeGenFromSource === RUN TestCodeGenFromSource/simple_line_counter === RUN TestCodeGenFromSource/count_a @@ -1596,7 +1632,7 @@ === RUN TestCodeGenFromSource/negative_numbers_in_capture_groups === RUN TestCodeGenFromSource/substitution === RUN TestCodeGenFromSource/const_term_as_pattern ---- PASS: TestCodeGenFromSource (0.03s) +--- PASS: TestCodeGenFromSource (0.01s) --- PASS: TestCodeGenFromSource/simple_line_counter (0.00s) --- PASS: TestCodeGenFromSource/count_a (0.00s) --- PASS: TestCodeGenFromSource/strptime_and_capref (0.00s) @@ -1607,11 +1643,11 @@ --- PASS: TestCodeGenFromSource/cond_expr_eq (0.00s) --- PASS: TestCodeGenFromSource/cond_expr_le (0.00s) --- PASS: TestCodeGenFromSource/cond_expr_ge (0.00s) - --- PASS: TestCodeGenFromSource/cond_expr_ne (0.01s) + --- PASS: TestCodeGenFromSource/cond_expr_ne (0.00s) --- PASS: TestCodeGenFromSource/nested_cond (0.00s) --- PASS: TestCodeGenFromSource/deco (0.00s) --- PASS: TestCodeGenFromSource/length (0.00s) - --- PASS: TestCodeGenFromSource/bitwise (0.01s) + --- PASS: TestCodeGenFromSource/bitwise (0.00s) --- PASS: TestCodeGenFromSource/pow (0.00s) --- PASS: TestCodeGenFromSource/indexed_expr (0.00s) --- PASS: TestCodeGenFromSource/strtol (0.00s) @@ -1655,18 +1691,18 @@ --- PASS: TestCodeGenFromAST/subst (0.00s) --- PASS: TestCodeGenFromAST/regexp_subst (0.00s) PASS -ok github.com/google/mtail/internal/runtime/compiler/codegen 0.136s +ok github.com/google/mtail/internal/runtime/compiler/codegen 0.064s === RUN TestNilErrorPosition --- PASS: TestNilErrorPosition (0.00s) PASS -ok github.com/google/mtail/internal/runtime/compiler/errors 0.040s +ok github.com/google/mtail/internal/runtime/compiler/errors 0.031s === RUN TestOptimiser === RUN TestOptimiser/int_add === RUN TestOptimiser/float_mul === RUN TestOptimiser/int_float_pow === RUN TestOptimiser/float_int_mod === RUN TestOptimiser/nested_ops ---- PASS: TestOptimiser (0.00s) +--- PASS: TestOptimiser (0.01s) --- PASS: TestOptimiser/int_add (0.00s) --- PASS: TestOptimiser/float_mul (0.00s) --- PASS: TestOptimiser/int_float_pow (0.00s) @@ -1689,16 +1725,16 @@ --- PASS: TestConstFoldQuickIntComm/add (0.00s) --- PASS: TestConstFoldQuickIntComm/mul (0.00s) === RUN TestConstFoldQuickFloatComm -=== RUN TestConstFoldQuickFloatComm/add === RUN TestConstFoldQuickFloatComm/mul +=== RUN TestConstFoldQuickFloatComm/add --- PASS: TestConstFoldQuickFloatComm (0.00s) - --- PASS: TestConstFoldQuickFloatComm/add (0.00s) --- PASS: TestConstFoldQuickFloatComm/mul (0.00s) + --- PASS: TestConstFoldQuickFloatComm/add (0.00s) === RUN TestConstFoldQuickMixedComm === RUN TestConstFoldQuickMixedComm/add === RUN TestConstFoldQuickMixedComm/mul ---- PASS: TestConstFoldQuickMixedComm (0.02s) - --- PASS: TestConstFoldQuickMixedComm/add (0.02s) +--- PASS: TestConstFoldQuickMixedComm (0.01s) + --- PASS: TestConstFoldQuickMixedComm/add (0.00s) --- PASS: TestConstFoldQuickMixedComm/mul (0.00s) === RUN TestConstFoldQuickIntAddSub --- PASS: TestConstFoldQuickIntAddSub (0.00s) @@ -1707,15 +1743,15 @@ === RUN TestConstFoldQuickMixedAddSub --- PASS: TestConstFoldQuickMixedAddSub (0.00s) === RUN TestConstFoldQuickFloatMulDiv ---- PASS: TestConstFoldQuickFloatMulDiv (0.04s) +--- PASS: TestConstFoldQuickFloatMulDiv (0.02s) === RUN TestConstFoldQuickIntModAddition --- PASS: TestConstFoldQuickIntModAddition (0.00s) === RUN TestConstFoldQuickFloatModAddition --- PASS: TestConstFoldQuickFloatModAddition (0.00s) === RUN TestConstFoldQuickMixedPowProduct ---- PASS: TestConstFoldQuickMixedPowProduct (0.01s) +--- PASS: TestConstFoldQuickMixedPowProduct (0.00s) PASS -ok github.com/google/mtail/internal/runtime/compiler/opt 0.129s +ok github.com/google/mtail/internal/runtime/compiler/opt 0.092s === RUN TestLex === RUN TestLex/empty === RUN TestLex/spaces @@ -1742,7 +1778,7 @@ === RUN TestLex/unexpected_char === RUN TestLex/unterminated_regex === RUN TestLex/unterminated_quoted_string ---- PASS: TestLex (0.01s) +--- PASS: TestLex (0.00s) --- PASS: TestLex/empty (0.00s) --- PASS: TestLex/spaces (0.00s) --- PASS: TestLex/newlines (0.00s) @@ -1832,8 +1868,8 @@ === RUN TestParserRoundTrip/stop === RUN TestParserRoundTrip/substitution === RUN TestParserRoundTrip/pattern_in_arg_expr_list ---- PASS: TestParserRoundTrip (0.03s) - --- PASS: TestParserRoundTrip/empty (0.01s) +--- PASS: TestParserRoundTrip (0.00s) + --- PASS: TestParserRoundTrip/empty (0.00s) --- PASS: TestParserRoundTrip/newline (0.00s) --- PASS: TestParserRoundTrip/declare_counter (0.00s) --- PASS: TestParserRoundTrip/declare_counter_string_name (0.00s) @@ -1941,15 +1977,15 @@ === RUN TestTokenString --- PASS: TestTokenString (0.00s) PASS -ok github.com/google/mtail/internal/runtime/compiler/parser 0.126s +ok github.com/google/mtail/internal/runtime/compiler/parser 0.047s === RUN TestInsertLookup --- PASS: TestInsertLookup (0.00s) === RUN TestInsertLookupQuick ---- PASS: TestInsertLookupQuick (6.47s) +--- PASS: TestInsertLookupQuick (2.18s) === RUN TestNestedScope --- PASS: TestNestedScope (0.00s) PASS -ok github.com/google/mtail/internal/runtime/compiler/symbol 6.584s +ok github.com/google/mtail/internal/runtime/compiler/symbol 2.245s === RUN TestTypeUnification === RUN TestTypeUnification/None_None === RUN TestTypeUnification/String_String @@ -2061,7 +2097,7 @@ === RUN TestAsTypeError --- PASS: TestAsTypeError (0.00s) PASS -ok github.com/google/mtail/internal/runtime/compiler/types 0.096s +ok github.com/google/mtail/internal/runtime/compiler/types 0.038s === RUN TestInstrs === RUN TestInstrs/match === RUN TestInstrs/cmp_lt @@ -2125,7 +2161,7 @@ === RUN TestInstrs/fcmp_gt_false === RUN TestInstrs/scmp_eq_false === RUN TestInstrs/subst ---- PASS: TestInstrs (0.02s) +--- PASS: TestInstrs (0.01s) --- PASS: TestInstrs/match (0.00s) --- PASS: TestInstrs/cmp_lt (0.00s) --- PASS: TestInstrs/cmp_eq (0.00s) @@ -2164,7 +2200,7 @@ --- PASS: TestInstrs/neg (0.00s) --- PASS: TestInstrs/not (0.00s) --- PASS: TestInstrs/pow (0.00s) - --- PASS: TestInstrs/s2i_pop (0.02s) + --- PASS: TestInstrs/s2i_pop (0.00s) --- PASS: TestInstrs/s2i (0.00s) --- PASS: TestInstrs/s2f (0.00s) --- PASS: TestInstrs/i2f (0.00s) @@ -2221,9 +2257,9 @@ === RUN TestTimestampInstr --- PASS: TestTimestampInstr (0.00s) PASS -ok github.com/google/mtail/internal/runtime/vm 0.117s +ok github.com/google/mtail/internal/runtime/vm 0.050s === RUN TestTail ---- PASS: TestTail (0.03s) +--- PASS: TestTail (0.00s) === RUN TestTailErrors --- PASS: TestTailErrors (0.00s) === RUN TestHandleLogUpdate @@ -2242,7 +2278,7 @@ === RUN TestTailerOpenRetries --- PASS: TestTailerOpenRetries (0.00s) PASS -ok github.com/google/mtail/internal/tailer 0.096s +ok github.com/google/mtail/internal/tailer 0.048s === RUN TestNewErrors --- PASS: TestNewErrors (0.00s) === RUN TestDgramStreamReadCompletedBecauseSocketClosed @@ -2260,7 +2296,7 @@ === RUN TestFileStreamRead --- PASS: TestFileStreamRead (0.00s) === RUN TestFileStreamReadNonSingleByteEnd ---- PASS: TestFileStreamReadNonSingleByteEnd (0.08s) +--- PASS: TestFileStreamReadNonSingleByteEnd (0.01s) === RUN TestStreamDoesntBreakOnCorruptRune --- PASS: TestStreamDoesntBreakOnCorruptRune (0.00s) === RUN TestFileStreamTruncation @@ -2294,7 +2330,7 @@ --- PASS: TestSocketStreamReadCompletedBecauseCancel/unix (0.00s) --- PASS: TestSocketStreamReadCompletedBecauseCancel/tcp (0.00s) PASS -ok github.com/google/mtail/internal/tailer/logstream 0.204s +ok github.com/google/mtail/internal/tailer/logstream 0.065s === RUN TestDoOrTimeoutNeverOK --- PASS: TestDoOrTimeoutNeverOK (0.01s) === RUN TestDoOrTimeoutAlwaysOK @@ -2304,7 +2340,7 @@ === RUN TestDoOrTimeoutAlwaysErr --- PASS: TestDoOrTimeoutAlwaysErr (0.00s) PASS -ok github.com/google/mtail/internal/testutil 0.168s +ok github.com/google/mtail/internal/testutil 0.104s === RUN TestTestWakerWakes --- PASS: TestTestWakerWakes (0.00s) === RUN TestTestWakerTwoWakees @@ -2314,7 +2350,7 @@ === RUN TestTimedWakerWakes --- PASS: TestTimedWakerWakes (0.01s) PASS -ok github.com/google/mtail/internal/waker 0.104s +ok github.com/google/mtail/internal/waker 0.043s # Only run race tests on amd64. test "arm64" != amd64 || \ dh_auto_test -- -timeout 20m -race -tags=integration @@ -2360,8 +2396,8 @@ dpkg-gencontrol: warning: package mtail: substitution variable ${misc:Static-Built-Using} unused, but is defined dh_md5sums -O--buildsystem=golang -O--builddirectory=/build/reproducible-path/mtail-3.0.0\~rc54\+git0ff5/build dh_builddeb -O--buildsystem=golang -O--builddirectory=/build/reproducible-path/mtail-3.0.0\~rc54\+git0ff5/build -dpkg-deb: building package 'mtail' in '../mtail_3.0.0~rc54+git0ff5-1_arm64.deb'. dpkg-deb: building package 'mtail-dbgsym' in '../mtail-dbgsym_3.0.0~rc54+git0ff5-1_arm64.deb'. +dpkg-deb: building package 'mtail' in '../mtail_3.0.0~rc54+git0ff5-1_arm64.deb'. dpkg-genbuildinfo --build=binary -O../mtail_3.0.0~rc54+git0ff5-1_arm64.buildinfo dpkg-genchanges --build=binary -O../mtail_3.0.0~rc54+git0ff5-1_arm64.changes dpkg-genchanges: info: binary-only upload (no source code included) @@ -2369,12 +2405,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/4156631/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/4156631/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/603206 and its subdirectories -I: Current time: Fri May 30 19:02:58 -12 2025 -I: pbuilder-time-stamp: 1748674978 +I: removing directory /srv/workspace/pbuilder/4156631 and its subdirectories +I: Current time: Sun Apr 28 14:41:26 +14 2024 +I: pbuilder-time-stamp: 1714264886