Diff of the two buildlogs: -- --- b1/build.log 2024-12-06 01:36:40.069906008 +0000 +++ b2/build.log 2024-12-06 01:41:46.896058882 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed Jan 7 19:56:45 -12 2026 -I: pbuilder-time-stamp: 1767859005 +I: Current time: Fri Dec 6 15:36:42 +14 2024 +I: pbuilder-time-stamp: 1733449002 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -26,52 +26,84 @@ dpkg-source: info: unpacking garagemq_0.0~git20200204.15e6a9d+ds-5.debian.tar.xz I: using fakeroot in build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/489611/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/975698/tmp/hooks/D01_modify_environment starting +debug: Running on ionos11-amd64. +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 Dec 6 01:37 /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/975698/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/975698/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='amd64' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=42 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='amd64' + 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]="32" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu") + BASH_VERSION='5.2.32(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=amd64 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=20 ' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=x86_64 + HOST_ARCH=amd64 IFS=' ' - INVOCATION_ID='8a08725113fa4612ac6a75b020d12a9e' - 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='489611' - PS1='# ' - PS2='> ' + INVOCATION_ID=ac16800f305c424ba283e108a34ab7b6 + LANG=C + LANGUAGE=et_EE:et + LC_ALL=C + MACHTYPE=x86_64-pc-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=975698 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.VYmXIkVV/pbuilderrc_LHa8 --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.VYmXIkVV/b1 --logfile b1/build.log garagemq_0.0~git20200204.15e6a9d+ds-5.dsc' - SUDO_GID='110' - SUDO_UID='105' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://213.165.73.152: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.VYmXIkVV/pbuilderrc_qdRv --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.VYmXIkVV/b2 --logfile b2/build.log garagemq_0.0~git20200204.15e6a9d+ds-5.dsc' + SUDO_GID=111 + SUDO_UID=106 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://46.16.76.132:3128 I: uname -a - Linux ionos5-amd64 6.11.5+bpo-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.11.5-1~bpo12+1 (2024-11-11) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-28-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.119-1 (2024-11-22) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Nov 22 2024 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/489611/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Nov 22 14:40 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/975698/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -227,7 +259,7 @@ Get: 96 http://deb.debian.org/debian trixie/main amd64 golang-github-tidwall-rtree-dev all 0.0~git20180113.6cd4270-3 [12.8 kB] Get: 97 http://deb.debian.org/debian trixie/main amd64 golang-github-tidwall-grect-dev all 0.1.0-1 [5568 B] Get: 98 http://deb.debian.org/debian trixie/main amd64 golang-github-tidwall-buntdb-dev all 1.1.7-1 [27.7 kB] -Fetched 78.9 MB in 10s (8082 kB/s) +Fetched 78.9 MB in 10s (7907 kB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package golang-golang-x-sys-dev. (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 ... 19969 files and directories currently installed.) @@ -560,8 +592,8 @@ Setting up tzdata (2024b-4) ... Current default time zone: 'Etc/UTC' -Local time is now: Thu Jan 8 07:58:21 UTC 2026. -Universal Time is now: Thu Jan 8 07:58:21 UTC 2026. +Local time is now: Fri Dec 6 01:39:20 UTC 2024. +Universal Time is now: Fri Dec 6 01:39:20 UTC 2024. Run 'dpkg-reconfigure tzdata' if you wish to change it. Setting up golang-github-cespare-xxhash-dev (2.3.0-1) ... @@ -645,7 +677,11 @@ fakeroot is already the newest version (1.36-1). 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. I: Building the package -I: Running cd /build/reproducible-path/garagemq-0.0~git20200204.15e6a9d+ds/ && 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 > ../garagemq_0.0~git20200204.15e6a9d+ds-5_source.changes +I: user script /srv/workspace/pbuilder/975698/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/975698/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/garagemq-0.0~git20200204.15e6a9d+ds/ && 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 > ../garagemq_0.0~git20200204.15e6a9d+ds-5_source.changes dpkg-buildpackage: info: source package garagemq dpkg-buildpackage: info: source version 0.0~git20200204.15e6a9d+ds-5 dpkg-buildpackage: info: source distribution unstable @@ -663,53 +699,53 @@ dh_autoreconf -O--buildsystem=golang dh_auto_configure -O--buildsystem=golang dh_auto_build -O--buildsystem=golang - cd obj-x86_64-linux-gnu && go install -trimpath -v -p 42 github.com/valinurovam/garagemq github.com/valinurovam/garagemq/admin github.com/valinurovam/garagemq/amqp github.com/valinurovam/garagemq/auth github.com/valinurovam/garagemq/binding github.com/valinurovam/garagemq/config github.com/valinurovam/garagemq/consumer github.com/valinurovam/garagemq/exchange github.com/valinurovam/garagemq/interfaces github.com/valinurovam/garagemq/metrics github.com/valinurovam/garagemq/msgstorage github.com/valinurovam/garagemq/pool github.com/valinurovam/garagemq/protocol github.com/valinurovam/garagemq/qos github.com/valinurovam/garagemq/queue github.com/valinurovam/garagemq/safequeue github.com/valinurovam/garagemq/server github.com/valinurovam/garagemq/srvstorage github.com/valinurovam/garagemq/storage + cd obj-x86_64-linux-gnu && go install -trimpath -v -p 20 github.com/valinurovam/garagemq github.com/valinurovam/garagemq/admin github.com/valinurovam/garagemq/amqp github.com/valinurovam/garagemq/auth github.com/valinurovam/garagemq/binding github.com/valinurovam/garagemq/config github.com/valinurovam/garagemq/consumer github.com/valinurovam/garagemq/exchange github.com/valinurovam/garagemq/interfaces github.com/valinurovam/garagemq/metrics github.com/valinurovam/garagemq/msgstorage github.com/valinurovam/garagemq/pool github.com/valinurovam/garagemq/protocol github.com/valinurovam/garagemq/qos github.com/valinurovam/garagemq/queue github.com/valinurovam/garagemq/safequeue github.com/valinurovam/garagemq/server github.com/valinurovam/garagemq/srvstorage github.com/valinurovam/garagemq/storage +encoding internal/asan -internal/race -internal/coverage/rtcov +unicode +math/bits +internal/godebugs +internal/byteorder internal/goexperiment -github.com/dgraph-io/badger/options -vendor/golang.org/x/crypto/internal/alias -internal/goarch -internal/msan internal/itoa internal/profilerecord -log/internal -unicode/utf8 -unicode internal/cpu -math/bits +internal/unsafeheader +unicode/utf8 sync/atomic internal/runtime/syscall -crypto/internal/alias -github.com/tidwall/tinyqueue -google.golang.org/protobuf/internal/flags -internal/godebugs -internal/unsafeheader -github.com/tidwall/btree -github.com/dgryski/go-farm -github.com/dgraph-io/badger/trie cmp -encoding -crypto/subtle +internal/runtime/atomic +internal/goos +internal/race +internal/coverage/rtcov +internal/goarch +internal/msan +unicode/utf16 +log/internal internal/nettrace +container/list +crypto/internal/alias +crypto/internal/boring/sig +crypto/subtle vendor/golang.org/x/crypto/cryptobyte/asn1 -unicode/utf16 +vendor/golang.org/x/crypto/internal/alias +github.com/dgraph-io/badger/options +google.golang.org/protobuf/internal/flags runtime/internal/math -internal/goos internal/abi -crypto/internal/boring/sig -internal/byteorder -internal/runtime/atomic -container/list -github.com/pelletier/go-toml/v2/internal/characters runtime/internal/sys -github.com/tidwall/match -google.golang.org/protobuf/internal/set internal/chacha8rand +github.com/dgryski/go-farm +github.com/pelletier/go-toml/v2/internal/characters +github.com/dgraph-io/badger/trie +google.golang.org/protobuf/internal/set +github.com/tidwall/btree +github.com/tidwall/match +github.com/tidwall/tinyqueue +internal/runtime/exithook internal/bytealg math -internal/runtime/exithook internal/stringslite runtime github.com/tidwall/rtree/base @@ -719,205 +755,211 @@ sync maps slices +internal/testlog internal/singleflight -internal/bisect github.com/spf13/viper/internal/encoding github.com/valinurovam/garagemq/qos google.golang.org/protobuf/internal/pragma -internal/testlog +internal/bisect github.com/tidwall/rtree runtime/cgo errors sort -internal/oserror -internal/godebug -path io +path +internal/godebug vendor/golang.org/x/net/dns/dnsmessage -strconv -crypto/internal/edwards25519/field -math/rand -container/heap -syscall -github.com/hashicorp/hcl/hcl/strconv math/rand/v2 +internal/oserror +crypto/internal/edwards25519/field +strconv crypto/internal/nistec/fiat -github.com/tidwall/pretty bytes strings internal/concurrent hash +syscall +github.com/hashicorp/hcl/hcl/strconv crypto/internal/randutil +container/heap reflect -crypto/rc4 +math/rand crypto/internal/edwards25519 -golang.org/x/crypto/blowfish +bufio +hash/fnv unique +golang.org/x/text/transform +github.com/tidwall/pretty crypto -hash/fnv hash/crc32 -internal/syscall/unix -internal/syscall/execenv -time -crypto/md5 -net/netip -golang.org/x/text/transform +crypto/rc4 crypto/cipher vendor/golang.org/x/text/transform -github.com/valinurovam/garagemq/pool net/http/internal/ascii -bufio html +github.com/valinurovam/garagemq/pool regexp/syntax +golang.org/x/crypto/blowfish +crypto/md5 golang.org/x/text/runes crypto/internal/boring crypto/des +net/netip +internal/syscall/execenv +internal/syscall/unix +time +crypto/aes crypto/hmac crypto/sha512 -crypto/aes crypto/sha1 crypto/sha256 vendor/golang.org/x/crypto/hkdf regexp +io/fs +internal/poll context github.com/valinurovam/garagemq/metrics github.com/tidwall/gjson -io/fs -internal/poll -github.com/spf13/afero/internal/common internal/filepathlite +github.com/spf13/afero/internal/common embed google.golang.org/protobuf/internal/editiondefaults crypto/internal/nistec -github.com/tidwall/grect os -crypto/ecdh internal/fmtsort encoding/binary -io/ioutil -path/filepath -github.com/tidwall/buntdb -fmt -vendor/golang.org/x/sys/cpu -os/signal +github.com/tidwall/grect encoding/base64 -google.golang.org/protobuf/internal/detrand +crypto/ecdh vendor/golang.org/x/crypto/chacha20 -github.com/cespare/xxhash vendor/golang.org/x/crypto/internal/poly1305 +github.com/cespare/xxhash github.com/golang/snappy golang.org/x/sys/unix encoding/pem -net -vendor/golang.org/x/crypto/sha3 -vendor/golang.org/x/crypto/chacha20poly1305 +fmt +io/ioutil +google.golang.org/protobuf/internal/detrand +path/filepath +os/signal +vendor/golang.org/x/sys/cpu +github.com/tidwall/buntdb github.com/spf13/afero/mem +vendor/golang.org/x/crypto/chacha20poly1305 +vendor/golang.org/x/crypto/sha3 +flag +encoding/json log encoding/csv -flag -encoding/hex net/url -encoding/json +encoding/hex +compress/flate +mime/quotedprintable mime net/http/internal github.com/subosito/gotenv -github.com/hashicorp/hcl/hcl/token -text/tabwriter -mime/quotedprintable -github.com/pelletier/go-toml/v2/internal/danger -vendor/golang.org/x/text/unicode/norm -github.com/pkg/errors -golang.org/x/text/unicode/norm text/template/parse -github.com/valinurovam/garagemq/amqp -encoding/xml math/big -google.golang.org/protobuf/internal/version -google.golang.org/protobuf/internal/errors +vendor/golang.org/x/text/unicode/norm +golang.org/x/text/unicode/norm vendor/golang.org/x/net/http2/hpack -github.com/DataDog/zstd -go/token -gopkg.in/yaml.v3 -compress/flate -runtime/trace -gopkg.in/yaml.v2 +github.com/hashicorp/hcl/hcl/token +text/tabwriter gopkg.in/ini.v1 -google.golang.org/protobuf/encoding/protowire +vendor/golang.org/x/text/unicode/bidi +github.com/spf13/jwalterweatherman +github.com/pelletier/go-toml/v2/internal/danger +gopkg.in/yaml.v3 github.com/hashicorp/hcl/hcl/ast github.com/hashicorp/hcl/hcl/scanner github.com/hashicorp/hcl/json/token github.com/pelletier/go-toml/v2/unstable -github.com/spf13/jwalterweatherman -golang.org/x/net/internal/timeseries -vendor/golang.org/x/text/unicode/bidi -google.golang.org/protobuf/reflect/protoreflect +github.com/valinurovam/garagemq/amqp +gopkg.in/yaml.v2 +compress/gzip +google.golang.org/protobuf/internal/errors +go/token +github.com/fsnotify/fsnotify/internal github.com/hashicorp/hcl/json/scanner +google.golang.org/protobuf/internal/version +google.golang.org/protobuf/encoding/protowire github.com/hashicorp/hcl/hcl/parser +github.com/pkg/errors +golang.org/x/net/internal/timeseries github.com/hashicorp/hcl/json/parser -compress/gzip -github.com/hashicorp/hcl/hcl/printer -github.com/hashicorp/hcl +github.com/fsnotify/fsnotify +vendor/golang.org/x/text/secure/bidirule internal/profile runtime/pprof -github.com/pelletier/go-toml/v2/internal/tracker -vendor/golang.org/x/text/secure/bidirule +runtime/trace +google.golang.org/protobuf/reflect/protoreflect +encoding/xml text/template +github.com/hashicorp/hcl/hcl/printer +github.com/hashicorp/hcl +github.com/pelletier/go-toml/v2/internal/tracker +vendor/golang.org/x/net/idna +github.com/spf13/viper/internal/encoding/hcl +github.com/sirupsen/logrus +github.com/spf13/viper/internal/encoding/json +github.com/pelletier/go-toml/v2 +github.com/dgraph-io/ristretto/z +github.com/DataDog/zstd +net google.golang.org/protobuf/internal/encoding/messageset +google.golang.org/protobuf/internal/order +google.golang.org/protobuf/internal/descfmt google.golang.org/protobuf/internal/strs google.golang.org/protobuf/internal/genid -google.golang.org/protobuf/internal/order google.golang.org/protobuf/runtime/protoiface -google.golang.org/protobuf/internal/descfmt google.golang.org/protobuf/internal/descopts -github.com/valinurovam/garagemq/binding -github.com/valinurovam/garagemq/interfaces -github.com/valinurovam/garagemq/safequeue -github.com/valinurovam/garagemq/msgstorage -github.com/valinurovam/garagemq/exchange -google.golang.org/protobuf/reflect/protoregistry -google.golang.org/protobuf/internal/encoding/text -vendor/golang.org/x/net/idna -github.com/spf13/viper/internal/encoding/hcl -github.com/spf13/viper/internal/encoding/json -github.com/dgraph-io/ristretto/z -github.com/pelletier/go-toml/v2 -github.com/dgraph-io/ristretto -google.golang.org/protobuf/proto -google.golang.org/protobuf/internal/encoding/defval -github.com/valinurovam/garagemq/config -github.com/valinurovam/garagemq/queue -github.com/spf13/viper/internal/encoding/yaml -github.com/valinurovam/garagemq/protocol -html/template crypto/rand -crypto/internal/boring/bbig crypto/elliptic crypto/internal/bigmod +crypto/internal/boring/bbig encoding/asn1 crypto/dsa -github.com/dustin/go-humanize -github.com/fsnotify/fsnotify/internal -github.com/sirupsen/logrus -google.golang.org/protobuf/encoding/prototext -google.golang.org/protobuf/internal/filedesc -github.com/valinurovam/garagemq/srvstorage -github.com/valinurovam/garagemq/consumer +github.com/valinurovam/garagemq/binding +github.com/valinurovam/garagemq/safequeue +github.com/valinurovam/garagemq/interfaces +google.golang.org/protobuf/reflect/protoregistry crypto/ed25519 crypto/internal/hpke -golang.org/x/crypto/bcrypt crypto/internal/mlkem768 -github.com/fsnotify/fsnotify -github.com/spf13/viper/internal/encoding/toml -crypto/rsa +golang.org/x/crypto/bcrypt +github.com/valinurovam/garagemq/msgstorage +google.golang.org/protobuf/internal/encoding/text +github.com/valinurovam/garagemq/exchange +github.com/dgraph-io/ristretto github.com/valinurovam/garagemq/auth +github.com/dustin/go-humanize +github.com/spf13/viper/internal/encoding/yaml +github.com/valinurovam/garagemq/protocol +html/template +github.com/valinurovam/garagemq/config +google.golang.org/protobuf/proto +crypto/rsa +github.com/spf13/viper/internal/encoding/toml +google.golang.org/protobuf/internal/encoding/defval crypto/x509/pkix +github.com/valinurovam/garagemq/queue vendor/golang.org/x/crypto/cryptobyte github.com/spf13/cast +github.com/valinurovam/garagemq/consumer +github.com/valinurovam/garagemq/srvstorage +google.golang.org/protobuf/encoding/prototext +google.golang.org/protobuf/internal/filedesc crypto/ecdsa github.com/spf13/viper/internal/encoding/dotenv github.com/spf13/viper/internal/encoding/ini google.golang.org/protobuf/internal/encoding/tag google.golang.org/protobuf/internal/impl +google.golang.org/protobuf/internal/filetype +google.golang.org/protobuf/runtime/protoimpl +google.golang.org/protobuf/types/descriptorpb +google.golang.org/protobuf/types/gofeaturespb +google.golang.org/protobuf/reflect/protodesc +github.com/golang/protobuf/proto # github.com/DataDog/zstd cgo-gcc-prolog: In function '_cgo_1dd006291257_Cfunc_ZSTD_getDecompressedSize': cgo-gcc-prolog:117:2: warning: 'ZSTD_getDecompressedSize' is deprecated [-Wdeprecated-declarations] @@ -925,29 +967,23 @@ /usr/include/zstd.h:203:20: note: declared here 203 | unsigned long long ZSTD_getDecompressedSize(const void* src, size_t srcSize); | ^~~~~~~~~~~~~~~~~~~~~~~~ -vendor/golang.org/x/net/http/httpproxy -net/textproto +github.com/dgraph-io/badger/pb github.com/mitchellh/mapstructure +net/textproto +vendor/golang.org/x/net/http/httpproxy github.com/coreos/go-systemd/daemon crypto/x509 github.com/spf13/pflag vendor/golang.org/x/net/http/httpguts mime/multipart -google.golang.org/protobuf/internal/filetype crypto/tls -google.golang.org/protobuf/runtime/protoimpl -google.golang.org/protobuf/types/descriptorpb -google.golang.org/protobuf/types/gofeaturespb -google.golang.org/protobuf/reflect/protodesc -github.com/golang/protobuf/proto net/http/httptrace net/http -github.com/dgraph-io/badger/pb expvar +github.com/spf13/afero net/http/pprof -golang.org/x/net/trace github.com/magiconair/properties -github.com/spf13/afero +golang.org/x/net/trace github.com/spf13/viper/internal/encoding/javaproperties github.com/dgraph-io/badger/y github.com/dgraph-io/badger/skl @@ -961,7 +997,7 @@ debian/rules override_dh_auto_test make[1]: Entering directory '/build/reproducible-path/garagemq-0.0~git20200204.15e6a9d+ds' dh_auto_test || true - cd obj-x86_64-linux-gnu && go test -vet=off -v -p 42 github.com/valinurovam/garagemq github.com/valinurovam/garagemq/admin github.com/valinurovam/garagemq/amqp github.com/valinurovam/garagemq/auth github.com/valinurovam/garagemq/binding github.com/valinurovam/garagemq/config github.com/valinurovam/garagemq/consumer github.com/valinurovam/garagemq/exchange github.com/valinurovam/garagemq/interfaces github.com/valinurovam/garagemq/metrics github.com/valinurovam/garagemq/msgstorage github.com/valinurovam/garagemq/pool github.com/valinurovam/garagemq/protocol github.com/valinurovam/garagemq/qos github.com/valinurovam/garagemq/queue github.com/valinurovam/garagemq/safequeue github.com/valinurovam/garagemq/server github.com/valinurovam/garagemq/srvstorage github.com/valinurovam/garagemq/storage + cd obj-x86_64-linux-gnu && go test -vet=off -v -p 20 github.com/valinurovam/garagemq github.com/valinurovam/garagemq/admin github.com/valinurovam/garagemq/amqp github.com/valinurovam/garagemq/auth github.com/valinurovam/garagemq/binding github.com/valinurovam/garagemq/config github.com/valinurovam/garagemq/consumer github.com/valinurovam/garagemq/exchange github.com/valinurovam/garagemq/interfaces github.com/valinurovam/garagemq/metrics github.com/valinurovam/garagemq/msgstorage github.com/valinurovam/garagemq/pool github.com/valinurovam/garagemq/protocol github.com/valinurovam/garagemq/qos github.com/valinurovam/garagemq/queue github.com/valinurovam/garagemq/safequeue github.com/valinurovam/garagemq/server github.com/valinurovam/garagemq/srvstorage github.com/valinurovam/garagemq/storage # github.com/DataDog/zstd cgo-gcc-prolog: In function '_cgo_1dd006291257_Cfunc_ZSTD_getDecompressedSize': cgo-gcc-prolog:117:2: warning: 'ZSTD_getDecompressedSize' is deprecated [-Wdeprecated-declarations] @@ -1025,17 +1061,17 @@ === RUN TestNewConnectionError --- PASS: TestNewConnectionError (0.00s) PASS -ok github.com/valinurovam/garagemq/amqp 0.004s +ok github.com/valinurovam/garagemq/amqp 0.009s === RUN TestParsePlain_Success --- PASS: TestParsePlain_Success (0.00s) === RUN TestParsePlain_Failed_WrongFormat --- PASS: TestParsePlain_Failed_WrongFormat (0.00s) === RUN TestCheckPasswordHash_Bcrypt ---- PASS: TestCheckPasswordHash_Bcrypt (0.22s) +--- PASS: TestCheckPasswordHash_Bcrypt (0.27s) === RUN TestCheckPasswordHash_MD5 --- PASS: TestCheckPasswordHash_MD5 (0.00s) PASS -ok github.com/valinurovam/garagemq/auth 0.228s +ok github.com/valinurovam/garagemq/auth 0.282s === RUN TestBinding_MatchTopic --- PASS: TestBinding_MatchTopic (0.00s) === RUN TestBinding_MatchDirect @@ -1053,7 +1089,7 @@ === RUN TestBinding_NewBindingPanicOnBadXMatch --- PASS: TestBinding_NewBindingPanicOnBadXMatch (0.00s) PASS -ok github.com/valinurovam/garagemq/binding 0.004s +ok github.com/valinurovam/garagemq/binding 0.010s === RUN TestNew --- PASS: TestNew (0.00s) === RUN TestExchange_AppendBinding @@ -1103,7 +1139,7 @@ === RUN TestExchange_GetTypeAlias --- PASS: TestExchange_GetTypeAlias (0.00s) PASS -ok github.com/valinurovam/garagemq/exchange 0.005s +ok github.com/valinurovam/garagemq/exchange 0.006s === RUN TestAmqpQos_IsActive --- PASS: TestAmqpQos_IsActive (0.00s) === RUN TestAmqpQos_Dec @@ -1117,7 +1153,7 @@ === RUN TestAmqpQos_Copy --- PASS: TestAmqpQos_Copy (0.00s) PASS -ok github.com/valinurovam/garagemq/qos 0.004s +ok github.com/valinurovam/garagemq/qos 0.009s === RUN TestQueue_Property --- PASS: TestQueue_Property (0.00s) === RUN TestQueue_PushPop_Inactive @@ -1183,7 +1219,7 @@ === RUN TestQueue_SetMetrics --- PASS: TestQueue_SetMetrics (0.00s) === RUN TestQueue_LoadFromStorage_Swap ---- PASS: TestQueue_LoadFromStorage_Swap (0.26s) +--- PASS: TestQueue_LoadFromStorage_Swap (0.30s) === RUN TestQueue_LoadFromMsgStorage_LessMaxMessages --- PASS: TestQueue_LoadFromMsgStorage_LessMaxMessages (0.00s) === RUN TestQueue_LoadFromMsgStorage_OverMaxMessages @@ -1193,964 +1229,964 @@ === RUN TestQueue_CancelConsumers --- PASS: TestQueue_CancelConsumers (0.00s) PASS -ok github.com/valinurovam/garagemq/queue 0.270s +ok github.com/valinurovam/garagemq/queue 0.310s === RUN TestSafeQueue ---- PASS: TestSafeQueue (0.10s) +--- PASS: TestSafeQueue (0.19s) === RUN TestSafeQueue_PushHead ---- PASS: TestSafeQueue_PushHead (0.13s) +--- PASS: TestSafeQueue_PushHead (0.30s) === RUN TestSafeQueue_HeadItem ---- PASS: TestSafeQueue_HeadItem (0.01s) +--- PASS: TestSafeQueue_HeadItem (0.02s) === RUN TestSafeQueue_DirtyLength ---- PASS: TestSafeQueue_DirtyLength (0.01s) +--- PASS: TestSafeQueue_DirtyLength (0.02s) === RUN TestSafeQueue_Purge ---- PASS: TestSafeQueue_Purge (0.01s) +--- PASS: TestSafeQueue_Purge (0.02s) PASS -ok github.com/valinurovam/garagemq/safequeue 0.258s +ok github.com/valinurovam/garagemq/safequeue 0.554s ? github.com/valinurovam/garagemq/srvstorage [no test files] ? github.com/valinurovam/garagemq/storage [no test files] === RUN Test_BasicQos_Channel_Success -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:03 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:03 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.913818ms -badger 2026/01/07 19:59:03 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:03 INFO: Force compaction on level 0 done ---- PASS: Test_BasicQos_Channel_Success (0.06s) +badger 2024/12/06 15:40:59 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:40:59 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:40:59 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:40:59 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:40:59 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:40:59 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.840277ms +badger 2024/12/06 15:40:59 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:40:59 INFO: Force compaction on level 0 done +--- PASS: Test_BasicQos_Channel_Success (0.15s) === RUN Test_BasicQos_Global_Success -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:03 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:03 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.552025ms -badger 2026/01/07 19:59:03 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:03 INFO: Force compaction on level 0 done ---- PASS: Test_BasicQos_Global_Success (0.08s) +badger 2024/12/06 15:40:59 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:40:59 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:40:59 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:40:59 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:40:59 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:40:59 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.881582ms +badger 2024/12/06 15:40:59 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:40:59 INFO: Force compaction on level 0 done +--- PASS: Test_BasicQos_Global_Success (0.19s) === RUN Test_BasicQos_Check_Global_Success -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:03 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:03 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.955182ms -badger 2026/01/07 19:59:03 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:03 INFO: Force compaction on level 0 done ---- PASS: Test_BasicQos_Check_Global_Success (0.34s) +badger 2024/12/06 15:40:59 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:40:59 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:40:59 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:40:59 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:40:59 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:40:59 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.967445ms +badger 2024/12/06 15:40:59 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:40:59 INFO: Force compaction on level 0 done +--- PASS: Test_BasicQos_Check_Global_Success (0.89s) === RUN Test_BasicQos_Check_NonGlobal_Success -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:03 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:04 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.603377ms -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:04 INFO: Force compaction on level 0 done ---- PASS: Test_BasicQos_Check_NonGlobal_Success (0.26s) +badger 2024/12/06 15:41:01 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:01 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:01 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:01 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:01 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:01 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 13.102909ms +badger 2024/12/06 15:41:01 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:01 INFO: Force compaction on level 0 done +--- PASS: Test_BasicQos_Check_NonGlobal_Success (1.31s) === RUN Test_BasicPublish_Success -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:04 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.9852ms -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:04 INFO: Force compaction on level 0 done ---- PASS: Test_BasicPublish_Success (0.06s) +badger 2024/12/06 15:41:01 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:01 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:01 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:01 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:01 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:01 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 18.926478ms +badger 2024/12/06 15:41:01 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:01 INFO: Force compaction on level 0 done +--- PASS: Test_BasicPublish_Success (0.47s) === RUN Test_BasicPublish_Persistent_Success -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: Storing value log head: {Fid:0 Len:29 Offset:188} -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:04 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.4054ms -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:04 INFO: Force compaction on level 0 done -badger 2026/01/07 19:59:04 INFO: Storing value log head: {Fid:0 Len:29 Offset:186} -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:04 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.600984ms -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:04 INFO: Force compaction on level 0 done -badger 2026/01/07 19:59:04 INFO: All 1 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: Replaying file id: 0 at offset: 215 -badger 2026/01/07 19:59:04 INFO: Replay took: 3.586µs -badger 2026/01/07 19:59:04 INFO: All 1 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: Replaying file id: 0 at offset: 217 -badger 2026/01/07 19:59:04 INFO: Replay took: 3.152µs -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s ---- PASS: Test_BasicPublish_Persistent_Success (0.21s) +badger 2024/12/06 15:41:02 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:02 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:02 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:02 INFO: Storing value log head: {Fid:0 Len:29 Offset:188} +badger 2024/12/06 15:41:02 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:02 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 15.070213ms +badger 2024/12/06 15:41:02 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:02 INFO: Force compaction on level 0 done +badger 2024/12/06 15:41:02 INFO: Storing value log head: {Fid:0 Len:29 Offset:186} +badger 2024/12/06 15:41:02 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:02 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 11.626247ms +badger 2024/12/06 15:41:02 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:02 INFO: Force compaction on level 0 done +badger 2024/12/06 15:41:02 INFO: All 1 tables opened in 0s +badger 2024/12/06 15:41:02 INFO: Replaying file id: 0 at offset: 215 +badger 2024/12/06 15:41:02 INFO: Replay took: 5.653µs +badger 2024/12/06 15:41:02 INFO: All 1 tables opened in 0s +badger 2024/12/06 15:41:02 INFO: Replaying file id: 0 at offset: 217 +badger 2024/12/06 15:41:02 INFO: Replay took: 16.671µs +badger 2024/12/06 15:41:02 INFO: All 0 tables opened in 0s +--- PASS: Test_BasicPublish_Persistent_Success (0.43s) === RUN Test_BasicPublish_Persistent_Failed_QueueNonDurable -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:04 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.324026ms -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:04 INFO: Force compaction on level 0 done ---- PASS: Test_BasicPublish_Persistent_Failed_QueueNonDurable (0.32s) +badger 2024/12/06 15:41:02 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:02 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:02 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:02 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:02 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:02 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 15.67005ms +badger 2024/12/06 15:41:02 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:02 INFO: Force compaction on level 0 done +--- PASS: Test_BasicPublish_Persistent_Failed_QueueNonDurable (0.51s) === RUN Test_BasicPublish_Failed_ExchangeNotFound -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:04 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.64315ms -badger 2026/01/07 19:59:04 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:04 INFO: Force compaction on level 0 done ---- PASS: Test_BasicPublish_Failed_ExchangeNotFound (0.21s) +badger 2024/12/06 15:41:03 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:03 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:03 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:03 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:03 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:03 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 15.150939ms +badger 2024/12/06 15:41:03 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:03 INFO: Force compaction on level 0 done +--- PASS: Test_BasicPublish_Failed_ExchangeNotFound (0.30s) === RUN Test_BasicPublish_Failed_Immediate -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:04 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:05 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:05 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.494141ms -badger 2026/01/07 19:59:05 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:05 INFO: Force compaction on level 0 done ---- PASS: Test_BasicPublish_Failed_Immediate (0.18s) +badger 2024/12/06 15:41:03 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:03 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:03 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:03 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:03 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:03 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 13.289292ms +badger 2024/12/06 15:41:03 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:03 INFO: Force compaction on level 0 done +--- PASS: Test_BasicPublish_Failed_Immediate (0.26s) === RUN Test_BasicPublish_Failed_Mandatory -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:05 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:05 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.840652ms -badger 2026/01/07 19:59:05 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:05 INFO: Force compaction on level 0 done ---- PASS: Test_BasicPublish_Failed_Mandatory (0.23s) +badger 2024/12/06 15:41:03 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:03 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:03 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:03 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:03 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:03 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 16.923167ms +badger 2024/12/06 15:41:03 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:03 INFO: Force compaction on level 0 done +--- PASS: Test_BasicPublish_Failed_Mandatory (0.47s) === RUN Test_BasicConsume_WithOrderCheck_Success -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:05 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:05 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 44.69316ms -badger 2026/01/07 19:59:05 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:05 INFO: Force compaction on level 0 done ---- PASS: Test_BasicConsume_WithOrderCheck_Success (0.46s) +badger 2024/12/06 15:41:03 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:04 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:04 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 44.081697ms +badger 2024/12/06 15:41:04 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:04 INFO: Force compaction on level 0 done +--- PASS: Test_BasicConsume_WithOrderCheck_Success (0.44s) === RUN Test_BasicConsume_Failed_QueueNotFound -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:05 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:05 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.891765ms -badger 2026/01/07 19:59:05 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:05 INFO: Force compaction on level 0 done ---- PASS: Test_BasicConsume_Failed_QueueNotFound (0.13s) +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:04 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:04 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 15.668652ms +badger 2024/12/06 15:41:04 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:04 INFO: Force compaction on level 0 done +--- PASS: Test_BasicConsume_Failed_QueueNotFound (0.24s) === RUN Test_BasicConsume_Failed_SameTag -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:05 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:05 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.135259ms -badger 2026/01/07 19:59:05 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:05 INFO: Force compaction on level 0 done ---- PASS: Test_BasicConsume_Failed_SameTag (0.06s) +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:04 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:04 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 16.573253ms +badger 2024/12/06 15:41:04 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:04 INFO: Force compaction on level 0 done +--- PASS: Test_BasicConsume_Failed_SameTag (0.16s) === RUN Test_BasicConsume_Failed_ExclusiveQueue -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:05 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:06 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.029899ms -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:06 INFO: Force compaction on level 0 done ---- PASS: Test_BasicConsume_Failed_ExclusiveQueue (0.06s) +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:04 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:04 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:04 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 17.043168ms +badger 2024/12/06 15:41:04 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:04 INFO: Force compaction on level 0 done +--- PASS: Test_BasicConsume_Failed_ExclusiveQueue (0.18s) === RUN Test_BasicConsume_Success_Exclusive_Reconsume -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:06 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 2.840402ms -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:06 INFO: Force compaction on level 0 done ---- PASS: Test_BasicConsume_Success_Exclusive_Reconsume (0.05s) +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:05 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:05 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 13.98602ms +badger 2024/12/06 15:41:05 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:05 INFO: Force compaction on level 0 done +--- PASS: Test_BasicConsume_Success_Exclusive_Reconsume (0.14s) === RUN Test_BasicCancel_Success -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:06 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.08608ms -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:06 INFO: Force compaction on level 0 done ---- PASS: Test_BasicCancel_Success (0.05s) +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:05 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:05 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.568568ms +badger 2024/12/06 15:41:05 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:05 INFO: Force compaction on level 0 done +--- PASS: Test_BasicCancel_Success (0.13s) === RUN Test_BasicCancel_Failed_Unknown_Tag -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:06 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.877184ms -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:06 INFO: Force compaction on level 0 done ---- PASS: Test_BasicCancel_Failed_Unknown_Tag (0.06s) +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:05 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:05 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 13.525847ms +badger 2024/12/06 15:41:05 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:05 INFO: Force compaction on level 0 done +--- PASS: Test_BasicCancel_Failed_Unknown_Tag (0.15s) === RUN Test_BasicAck_Success -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:06 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.063012ms -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:06 INFO: Force compaction on level 0 done ---- PASS: Test_BasicAck_Success (0.25s) +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:05 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:05 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 16.512602ms +badger 2024/12/06 15:41:05 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:05 INFO: Force compaction on level 0 done +--- PASS: Test_BasicAck_Success (0.33s) === RUN Test_BasicAckMultiple_Success -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:06 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.304911ms -badger 2026/01/07 19:59:06 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:06 INFO: Force compaction on level 0 done ---- PASS: Test_BasicAckMultiple_Success (0.28s) +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:05 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:06 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:06 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:06 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 28.127764ms +badger 2024/12/06 15:41:06 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:06 INFO: Force compaction on level 0 done +--- PASS: Test_BasicAckMultiple_Success (0.43s) === RUN Test_BasicNack_RequeueTrue_Success -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:06 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:07 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:07 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:07 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 8.367751ms -badger 2026/01/07 19:59:07 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:07 INFO: Force compaction on level 0 done ---- PASS: Test_BasicNack_RequeueTrue_Success (0.35s) +badger 2024/12/06 15:41:06 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:06 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:06 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:06 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:06 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:06 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.520401ms +badger 2024/12/06 15:41:06 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:06 INFO: Force compaction on level 0 done +--- PASS: Test_BasicNack_RequeueTrue_Success (0.51s) === RUN Test_BasicNack_RequeueTrue_Multiple_Success -badger 2026/01/07 19:59:07 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:07 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:07 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:08 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:09 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:09 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 23.668173ms -badger 2026/01/07 19:59:09 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:09 INFO: Force compaction on level 0 done ---- PASS: Test_BasicNack_RequeueTrue_Multiple_Success (2.90s) +badger 2024/12/06 15:41:06 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:06 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:06 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:07 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:08 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:08 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.023595ms +badger 2024/12/06 15:41:08 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:08 INFO: Force compaction on level 0 done +--- PASS: Test_BasicNack_RequeueTrue_Multiple_Success (1.76s) === RUN Test_BasicNack_RequeueFalse_Success -badger 2026/01/07 19:59:10 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:11 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:12 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.739426ms -badger 2026/01/07 19:59:13 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:13 INFO: Force compaction on level 0 done ---- PASS: Test_BasicNack_RequeueFalse_Success (3.12s) +badger 2024/12/06 15:41:08 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:08 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:08 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:08 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:08 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:08 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.57894ms +badger 2024/12/06 15:41:08 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:08 INFO: Force compaction on level 0 done +--- PASS: Test_BasicNack_RequeueFalse_Success (0.36s) === RUN Test_BasicNack_RequeueFalse_Multiple_Success -badger 2026/01/07 19:59:13 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:13 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:13 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:14 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:14 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 19.315304ms -badger 2026/01/07 19:59:14 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:14 INFO: Force compaction on level 0 done ---- PASS: Test_BasicNack_RequeueFalse_Multiple_Success (1.63s) +badger 2024/12/06 15:41:08 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:08 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:08 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:09 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:09 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:09 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 18.675748ms +badger 2024/12/06 15:41:09 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:09 INFO: Force compaction on level 0 done +--- PASS: Test_BasicNack_RequeueFalse_Multiple_Success (0.41s) === RUN Test_BasicReject_RequeueTrue_Success -badger 2026/01/07 19:59:14 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:14 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:14 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:15 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:15 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:15 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.474261ms -badger 2026/01/07 19:59:15 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:15 INFO: Force compaction on level 0 done ---- PASS: Test_BasicReject_RequeueTrue_Success (0.91s) +badger 2024/12/06 15:41:09 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:09 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:09 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:09 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:09 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:09 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.287306ms +badger 2024/12/06 15:41:09 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:09 INFO: Force compaction on level 0 done +--- PASS: Test_BasicReject_RequeueTrue_Success (0.31s) === RUN Test_BasicReject_RequeueFalse_Success -badger 2026/01/07 19:59:15 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:15 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:15 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:15 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:15 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:15 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 13.053985ms -badger 2026/01/07 19:59:15 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:15 INFO: Force compaction on level 0 done ---- PASS: Test_BasicReject_RequeueFalse_Success (0.33s) +badger 2024/12/06 15:41:09 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:09 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:09 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:09 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:09 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:09 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.618263ms +badger 2024/12/06 15:41:09 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:09 INFO: Force compaction on level 0 done +--- PASS: Test_BasicReject_RequeueFalse_Success (0.40s) === RUN Test_BasicGet_Success -badger 2026/01/07 19:59:15 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:15 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:15 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:156} -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 8.881267ms -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:16 INFO: Force compaction on level 0 done ---- PASS: Test_BasicGet_Success (0.21s) +badger 2024/12/06 15:41:09 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:09 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:09 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: Storing value log head: {Fid:0 Len:29 Offset:156} +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:10 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.110165ms +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:10 INFO: Force compaction on level 0 done +--- PASS: Test_BasicGet_Success (0.11s) === RUN Test_BasicGet_Success_Empty -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:168} -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.771102ms -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:16 INFO: Force compaction on level 0 done ---- PASS: Test_BasicGet_Success_Empty (0.08s) +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: Storing value log head: {Fid:0 Len:29 Offset:168} +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:10 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.158118ms +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:10 INFO: Force compaction on level 0 done +--- PASS: Test_BasicGet_Success_Empty (0.11s) === RUN Test_BasicGet_Success_WithAck -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:172} -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 12.113958ms -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:16 INFO: Force compaction on level 0 done ---- PASS: Test_BasicGet_Success_WithAck (0.10s) +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: Storing value log head: {Fid:0 Len:29 Offset:172} +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:10 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 14.677225ms +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:10 INFO: Force compaction on level 0 done +--- PASS: Test_BasicGet_Success_WithAck (0.12s) === RUN Test_BasicGet_Succ -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:150} -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 25.172697ms -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:16 INFO: Force compaction on level 0 done ---- PASS: Test_BasicGet_Succ (0.19s) +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: Storing value log head: {Fid:0 Len:29 Offset:150} +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:10 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.771184ms +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:10 INFO: Force compaction on level 0 done +--- PASS: Test_BasicGet_Succ (0.10s) === RUN Test_BasicGet_Failed_QueueNotFound -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:182} -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.390436ms -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:16 INFO: Force compaction on level 0 done ---- PASS: Test_BasicGet_Failed_QueueNotFound (0.05s) +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: Storing value log head: {Fid:0 Len:29 Offset:182} +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:10 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.627985ms +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:10 INFO: Force compaction on level 0 done +--- PASS: Test_BasicGet_Failed_QueueNotFound (0.10s) === RUN Test_ChannelOpen_Success -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.863279ms -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:16 INFO: Force compaction on level 0 done ---- PASS: Test_ChannelOpen_Success (0.06s) +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:10 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.606442ms +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:10 INFO: Force compaction on level 0 done +--- PASS: Test_ChannelOpen_Success (0.12s) === RUN Test_ChannelOpen_FailedReopen -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.004587ms -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:16 INFO: Force compaction on level 0 done ---- PASS: Test_ChannelOpen_FailedReopen (0.05s) +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:10 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.83619ms +badger 2024/12/06 15:41:10 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:10 INFO: Force compaction on level 0 done +--- PASS: Test_ChannelOpen_FailedReopen (0.10s) === RUN Test_ChannelClose_Success -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.062852ms -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:16 INFO: Force compaction on level 0 done ---- PASS: Test_ChannelClose_Success (0.10s) +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:10 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:11 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:11 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:11 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:11 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 9.147727ms +badger 2024/12/06 15:41:11 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:11 INFO: Force compaction on level 0 done +--- PASS: Test_ChannelClose_Success (0.49s) === RUN Test_ChannelFlow_Active_Success -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.539677ms -badger 2026/01/07 19:59:16 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:16 INFO: Force compaction on level 0 done ---- PASS: Test_ChannelFlow_Active_Success (0.12s) +badger 2024/12/06 15:41:11 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:11 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:11 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:11 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:11 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:11 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 9.396353ms +badger 2024/12/06 15:41:11 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:11 INFO: Force compaction on level 0 done +--- PASS: Test_ChannelFlow_Active_Success (0.25s) === RUN Test_ChannelFlow_InActive_Success -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:16 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.313007ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_ChannelFlow_InActive_Success (0.14s) +badger 2024/12/06 15:41:11 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:11 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:11 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:11 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:11 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:11 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 9.997936ms +badger 2024/12/06 15:41:11 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:11 INFO: Force compaction on level 0 done +--- PASS: Test_ChannelFlow_InActive_Success (0.31s) === RUN Test_ChannelFlow_Failed_FlowOkSend -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.428184ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_ChannelFlow_Failed_FlowOkSend (0.13s) +badger 2024/12/06 15:41:11 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:11 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:11 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:12 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.677234ms +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:12 INFO: Force compaction on level 0 done +--- PASS: Test_ChannelFlow_Failed_FlowOkSend (0.28s) === RUN Test_Confirm_Success -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.529825ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_Confirm_Success (0.08s) +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:12 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 12.980987ms +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:12 INFO: Force compaction on level 0 done +--- PASS: Test_Confirm_Success (0.22s) === RUN Test_ConfirmReceive_Acks_Success -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.167141ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_ConfirmReceive_Acks_Success (0.12s) +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:12 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 11.300958ms +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:12 INFO: Force compaction on level 0 done +--- PASS: Test_ConfirmReceive_Acks_Success (0.19s) === RUN Test_ConfirmReceive_Acks_NoRoute_Success -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.503536ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_ConfirmReceive_Acks_NoRoute_Success (0.11s) +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:12 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 8.51617ms +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:12 INFO: Force compaction on level 0 done +--- PASS: Test_ConfirmReceive_Acks_NoRoute_Success (0.14s) === RUN Test_ConfirmReceive_Acks_Persistent_Success -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:1770} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.909339ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:200} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.948249ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_ConfirmReceive_Acks_Persistent_Success (0.13s) +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: Storing value log head: {Fid:0 Len:29 Offset:1770} +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:12 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 18.982968ms +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:12 INFO: Force compaction on level 0 done +badger 2024/12/06 15:41:12 INFO: Storing value log head: {Fid:0 Len:29 Offset:200} +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:12 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 35.605488ms +badger 2024/12/06 15:41:12 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:12 INFO: Force compaction on level 0 done +--- PASS: Test_ConfirmReceive_Acks_Persistent_Success (0.30s) === RUN Test_Connection_Success -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.227401ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_Connection_Success (0.06s) +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:12 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.767445ms +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:13 INFO: Force compaction on level 0 done +--- PASS: Test_Connection_Success (0.13s) === RUN Test_Connection_FailedVhostAccess -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:55} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.436143ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_Connection_FailedVhostAccess (0.07s) +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:55} +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 9.122922ms +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:13 INFO: Force compaction on level 0 done +--- PASS: Test_Connection_FailedVhostAccess (0.11s) === RUN Test_Connection_Failed_WhenWrongAuth -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.363452ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_Connection_Failed_WhenWrongAuth (0.06s) +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.696501ms +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:13 INFO: Force compaction on level 0 done +--- PASS: Test_Connection_Failed_WhenWrongAuth (0.09s) === RUN Test_Connection_Failed_WhenWrongAuth_UnknownUser -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.538325ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_Connection_Failed_WhenWrongAuth_UnknownUser (0.06s) +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.87256ms +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:13 INFO: Force compaction on level 0 done +--- PASS: Test_Connection_Failed_WhenWrongAuth_UnknownUser (0.10s) === RUN Test_DefaultExchanges -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.804144ms -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:17 INFO: Force compaction on level 0 done ---- PASS: Test_DefaultExchanges (0.06s) +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.303812ms +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:13 INFO: Force compaction on level 0 done +--- PASS: Test_DefaultExchanges (0.10s) === RUN Test_ExchangeDeclare_Success -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.376453ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done ---- PASS: Test_ExchangeDeclare_Success (0.07s) +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.699156ms +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:13 INFO: Force compaction on level 0 done +--- PASS: Test_ExchangeDeclare_Success (0.08s) === RUN Test_ExchangeDeclareDurable_Success -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:125} -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.346568ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done ---- PASS: Test_ExchangeDeclareDurable_Success (0.08s) +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:125} +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 8.215942ms +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:13 INFO: Force compaction on level 0 done +--- PASS: Test_ExchangeDeclareDurable_Success (0.09s) === RUN Test_ExchangeDeclare_Success_RedeclareEqual -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.795748ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done ---- PASS: Test_ExchangeDeclare_Success_RedeclareEqual (0.06s) +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.559145ms +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:13 INFO: Force compaction on level 0 done +--- PASS: Test_ExchangeDeclare_Success_RedeclareEqual (0.10s) === RUN Test_ExchangeDeclare_Failed_WrongType -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.155682ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done ---- PASS: Test_ExchangeDeclare_Failed_WrongType (0.06s) +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.792378ms +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:13 INFO: Force compaction on level 0 done +--- PASS: Test_ExchangeDeclare_Failed_WrongType (0.13s) === RUN Test_ExchangeDeclare_Failed_RedeclareNotEqual -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.609443ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done ---- PASS: Test_ExchangeDeclare_Failed_RedeclareNotEqual (0.07s) +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:13 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.600995ms +badger 2024/12/06 15:41:13 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:13 INFO: Force compaction on level 0 done +--- PASS: Test_ExchangeDeclare_Failed_RedeclareNotEqual (0.13s) === RUN Test_ExchangeDeclare_Failed_EmptyName -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.624374ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done ---- PASS: Test_ExchangeDeclare_Failed_EmptyName (0.06s) +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:13 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:14 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.352097ms +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:14 INFO: Force compaction on level 0 done +--- PASS: Test_ExchangeDeclare_Failed_EmptyName (0.09s) === RUN Test_ExchangeDeclare_Failed_DefaultName -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.740435ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done ---- PASS: Test_ExchangeDeclare_Failed_DefaultName (0.07s) +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:14 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.70238ms +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:14 INFO: Force compaction on level 0 done +--- PASS: Test_ExchangeDeclare_Failed_DefaultName (0.10s) === RUN Test_ExchangeDeclarePassive_Success -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.179294ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done ---- PASS: Test_ExchangeDeclarePassive_Success (0.07s) +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:14 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 11.092112ms +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:14 INFO: Force compaction on level 0 done +--- PASS: Test_ExchangeDeclarePassive_Success (0.11s) === RUN Test_ExchangeDeclarePassive_Failed_NotExists -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.399789ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done ---- PASS: Test_ExchangeDeclarePassive_Failed_NotExists (0.09s) +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:14 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.352494ms +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:14 INFO: Force compaction on level 0 done +--- PASS: Test_ExchangeDeclarePassive_Failed_NotExists (0.12s) === RUN Test_ServerPersist_Queue_Success -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:178} -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.587272ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done -badger 2026/01/07 19:59:18 INFO: All 1 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Replaying file id: 0 at offset: 207 -badger 2026/01/07 19:59:18 INFO: Replay took: 3.613µs -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Replaying file id: 0 at offset: 0 -badger 2026/01/07 19:59:18 INFO: Replay took: 3.284µs -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s ---- PASS: Test_ServerPersist_Queue_Success (0.17s) +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: Storing value log head: {Fid:0 Len:29 Offset:178} +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:14 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.076526ms +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:14 INFO: Force compaction on level 0 done +badger 2024/12/06 15:41:14 INFO: All 1 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: Replaying file id: 0 at offset: 207 +badger 2024/12/06 15:41:14 INFO: Replay took: 5.076µs +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: Replaying file id: 0 at offset: 0 +badger 2024/12/06 15:41:14 INFO: Replay took: 4.466µs +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +--- PASS: Test_ServerPersist_Queue_Success (0.30s) === RUN Test_ServerPersist_Exchange_Success -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:228} -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 12.695353ms -badger 2026/01/07 19:59:18 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:18 INFO: Force compaction on level 0 done -badger 2026/01/07 19:59:18 INFO: All 1 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Replaying file id: 0 at offset: 257 -badger 2026/01/07 19:59:18 INFO: Replay took: 4.013µs -badger 2026/01/07 19:59:18 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:18 INFO: Replaying file id: 0 at offset: 0 -badger 2026/01/07 19:59:18 INFO: Replay took: 4.125µs -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s ---- PASS: Test_ServerPersist_Exchange_Success (0.29s) +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:14 INFO: Storing value log head: {Fid:0 Len:29 Offset:228} +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:14 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.757385ms +badger 2024/12/06 15:41:14 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:14 INFO: Force compaction on level 0 done +badger 2024/12/06 15:41:14 INFO: All 1 tables opened in 0s +badger 2024/12/06 15:41:15 INFO: Replaying file id: 0 at offset: 257 +badger 2024/12/06 15:41:15 INFO: Replay took: 4.284µs +badger 2024/12/06 15:41:15 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:15 INFO: Replaying file id: 0 at offset: 0 +badger 2024/12/06 15:41:15 INFO: Replay took: 78.837µs +badger 2024/12/06 15:41:16 INFO: All 0 tables opened in 0s +--- PASS: Test_ServerPersist_Exchange_Success (1.64s) === RUN Test_QueueDeclare_Success -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.467985ms -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:19 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclare_Success (0.17s) +badger 2024/12/06 15:41:16 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:16 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:16 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 8.468766ms +badger 2024/12/06 15:41:16 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:16 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclare_Success (0.25s) === RUN Test_QueueDeclareDurable_Success -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:178} -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.739042ms -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:19 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclareDurable_Success (0.16s) +badger 2024/12/06 15:41:16 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:16 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:16 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:16 INFO: Storing value log head: {Fid:0 Len:29 Offset:178} +badger 2024/12/06 15:41:16 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:16 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 15.73775ms +badger 2024/12/06 15:41:16 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:16 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclareDurable_Success (0.28s) === RUN Test_QueueDeclare_HasDefaultRoute -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.394154ms -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:19 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclare_HasDefaultRoute (0.16s) +badger 2024/12/06 15:41:16 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:16 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 12.408774ms +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:17 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclare_HasDefaultRoute (0.22s) === RUN Test_QueueDeclare_Success_RedeclareEqual -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 15.388782ms -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:19 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclare_Success_RedeclareEqual (0.19s) +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 8.641419ms +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:17 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclare_Success_RedeclareEqual (0.25s) === RUN Test_QueueDeclare_Failed_RedeclareNotEqual -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.522444ms -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:19 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclare_Failed_RedeclareNotEqual (0.18s) +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 14.180438ms +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:17 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclare_Failed_RedeclareNotEqual (0.15s) === RUN Test_QueueDeclare_Failed_EmptyName -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.679737ms -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:19 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclare_Failed_EmptyName (0.05s) +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 13.529812ms +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:17 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclare_Failed_EmptyName (0.15s) === RUN Test_QueueDeclarePassive_Success -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.563305ms -badger 2026/01/07 19:59:19 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:19 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclarePassive_Success (0.05s) +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 16.341576ms +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:17 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclarePassive_Success (0.15s) === RUN Test_QueueDeclarePassive_Failed_NotExists -badger 2026/01/07 19:59:19 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.717662ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclarePassive_Failed_NotExists (0.05s) +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:17 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 11.440821ms +badger 2024/12/06 15:41:17 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:17 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclarePassive_Failed_NotExists (0.15s) === RUN Test_QueueDeclarePassive_Failed_Locked -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:290} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.632095ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclarePassive_Failed_Locked (0.06s) +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:17 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:290} +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.292398ms +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:18 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclarePassive_Failed_Locked (0.14s) === RUN Test_QueueDeclareExclusive_Success -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:278} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.04972ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclareExclusive_Success (0.15s) +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:278} +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 9.616579ms +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:18 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclareExclusive_Success (0.21s) === RUN Test_QueueDeclareExclusive_Failed_Locked -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:296} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 12.732594ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclareExclusive_Failed_Locked (0.16s) +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:296} +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 12.976198ms +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:18 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclareExclusive_Failed_Locked (0.12s) === RUN Test_QueueDeclareNotExclusive_Success -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.197175ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeclareNotExclusive_Success (0.05s) +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.336639ms +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:18 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeclareNotExclusive_Success (0.14s) === RUN Test_QueueBind_Success -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.614643ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueBind_Success (0.05s) +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.801686ms +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:18 INFO: Force compaction on level 0 done +--- PASS: Test_QueueBind_Success (0.12s) === RUN Test_QueueBind_Success_Rebind -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.318285ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueBind_Success_Rebind (0.05s) +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 11.070189ms +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:18 INFO: Force compaction on level 0 done +--- PASS: Test_QueueBind_Success_Rebind (0.12s) === RUN Test_QueueBind_Failed_ExchangeNotExists -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:293} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.855553ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueBind_Failed_ExchangeNotExists (0.06s) +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: Storing value log head: {Fid:0 Len:29 Offset:293} +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:18 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 22.248831ms +badger 2024/12/06 15:41:18 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:18 INFO: Force compaction on level 0 done +--- PASS: Test_QueueBind_Failed_ExchangeNotExists (0.17s) === RUN Test_QueueBind_Failed_QueueNotExists -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:284} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.106089ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueBind_Failed_QueueNotExists (0.05s) +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:18 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:284} +badger 2024/12/06 15:41:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 190.538515ms +badger 2024/12/06 15:41:19 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:19 INFO: Force compaction on level 0 done +--- PASS: Test_QueueBind_Failed_QueueNotExists (0.52s) === RUN Test_QueueBind_Failed_OnExclusiveQueue -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:290} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.86023ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueBind_Failed_OnExclusiveQueue (0.05s) +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:290} +badger 2024/12/06 15:41:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.183741ms +badger 2024/12/06 15:41:19 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:19 INFO: Force compaction on level 0 done +--- PASS: Test_QueueBind_Failed_OnExclusiveQueue (0.17s) === RUN Test_QueueUnbind_Success -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:149} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.827709ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueUnbind_Success (0.05s) +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:149} +badger 2024/12/06 15:41:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.103242ms +badger 2024/12/06 15:41:19 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:19 INFO: Force compaction on level 0 done +--- PASS: Test_QueueUnbind_Success (0.17s) === RUN Test_QueueUnbind_FailedExchangeNotExists -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 9.354943ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueUnbind_FailedExchangeNotExists (0.06s) +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:19 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:19 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 9.92553ms +badger 2024/12/06 15:41:19 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:19 INFO: Force compaction on level 0 done +--- PASS: Test_QueueUnbind_FailedExchangeNotExists (0.12s) === RUN Test_QueueUnbind_FailedQueueNotExists -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.90407ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueUnbind_FailedQueueNotExists (0.05s) +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:19 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 12.375221ms +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:20 INFO: Force compaction on level 0 done +--- PASS: Test_QueueUnbind_FailedQueueNotExists (0.13s) === RUN Test_QueueUnbind_Failed_OnExclusiveQueue -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:296} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 6.789616ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueueUnbind_Failed_OnExclusiveQueue (0.06s) +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:296} +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 11.898074ms +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:20 INFO: Force compaction on level 0 done +--- PASS: Test_QueueUnbind_Failed_OnExclusiveQueue (0.12s) === RUN Test_QueuePurge_Success -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.185588ms -badger 2026/01/07 19:59:20 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:20 INFO: Force compaction on level 0 done ---- PASS: Test_QueuePurge_Success (0.05s) +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 9.131927ms +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:20 INFO: Force compaction on level 0 done +--- PASS: Test_QueuePurge_Success (0.29s) === RUN Test_QueuePurge_Failed_QueueNotExists -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:287} -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.776024ms -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:21 INFO: Force compaction on level 0 done ---- PASS: Test_QueuePurge_Failed_QueueNotExists (0.05s) +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:287} +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 13.689475ms +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:20 INFO: Force compaction on level 0 done +--- PASS: Test_QueuePurge_Failed_QueueNotExists (0.15s) === RUN Test_QueuePurge_Failed_OnExclusiveQueue -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:293} -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.20719ms -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:21 INFO: Force compaction on level 0 done ---- PASS: Test_QueuePurge_Failed_OnExclusiveQueue (0.05s) +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:293} +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 21.692797ms +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:20 INFO: Force compaction on level 0 done +--- PASS: Test_QueuePurge_Failed_OnExclusiveQueue (0.15s) === RUN Test_QueueDelete_Success -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:248} -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.352519ms -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:21 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDelete_Success (0.07s) +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: Storing value log head: {Fid:0 Len:29 Offset:248} +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:20 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 11.597151ms +badger 2024/12/06 15:41:20 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:20 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDelete_Success (0.14s) === RUN Test_QueueDeleteDurable_Success -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:393} -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.892237ms -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:21 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDeleteDurable_Success (0.07s) +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:20 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:393} +badger 2024/12/06 15:41:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 13.978449ms +badger 2024/12/06 15:41:21 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:21 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDeleteDurable_Success (0.17s) === RUN Test_QueueDelete_Failed_NotEmpty -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.986855ms -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:21 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDelete_Failed_NotEmpty (0.08s) +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 21.706064ms +badger 2024/12/06 15:41:21 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:21 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDelete_Failed_NotEmpty (0.14s) === RUN Test_QueueDelete_Failed_QueueNotExists -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:290} -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.644154ms -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:21 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDelete_Failed_QueueNotExists (0.08s) +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:290} +badger 2024/12/06 15:41:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 10.669863ms +badger 2024/12/06 15:41:21 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:21 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDelete_Failed_QueueNotExists (0.12s) === RUN Test_QueueDelete_Failed_OnExclusiveQueue -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:296} -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.984203ms -badger 2026/01/07 19:59:21 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:21 INFO: Force compaction on level 0 done ---- PASS: Test_QueueDelete_Failed_OnExclusiveQueue (0.08s) +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: Storing value log head: {Fid:0 Len:29 Offset:296} +badger 2024/12/06 15:41:21 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:21 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 8.706545ms +badger 2024/12/06 15:41:21 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:21 INFO: Force compaction on level 0 done +--- PASS: Test_QueueDelete_Failed_OnExclusiveQueue (0.11s) === RUN Test_Basic_AutoDelete -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:21 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: Storing value log head: {Fid:0 Len:29 Offset:239} -badger 2026/01/07 19:59:22 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:22 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.979032ms -badger 2026/01/07 19:59:22 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:22 INFO: Force compaction on level 0 done ---- PASS: Test_Basic_AutoDelete (1.12s) +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:21 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:22 INFO: Storing value log head: {Fid:0 Len:29 Offset:239} +badger 2024/12/06 15:41:22 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:22 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.330586ms +badger 2024/12/06 15:41:22 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:22 INFO: Force compaction on level 0 done +--- PASS: Test_Basic_AutoDelete (1.17s) === RUN TestServer_GetConnections -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:22 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:22 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.253273ms -badger 2026/01/07 19:59:22 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:22 INFO: Force compaction on level 0 done ---- PASS: TestServer_GetConnections (0.05s) +badger 2024/12/06 15:41:22 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:22 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:22 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:22 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:22 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:22 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.280578ms +badger 2024/12/06 15:41:22 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:22 INFO: Force compaction on level 0 done +--- PASS: TestServer_GetConnections (0.09s) === RUN TestServer_GetProtoVersion -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:22 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:22 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 4.774809ms -badger 2026/01/07 19:59:22 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:22 INFO: Force compaction on level 0 done ---- PASS: TestServer_GetProtoVersion (0.05s) +badger 2024/12/06 15:41:22 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:22 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:22 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:22 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:22 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:22 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.100032ms +badger 2024/12/06 15:41:22 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:22 INFO: Force compaction on level 0 done +--- PASS: TestServer_GetProtoVersion (0.09s) === RUN TestServer_GetVhosts -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} -badger 2026/01/07 19:59:22 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:22 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 5.552979ms -badger 2026/01/07 19:59:22 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:22 INFO: Force compaction on level 0 done ---- PASS: TestServer_GetVhosts (0.08s) +badger 2024/12/06 15:41:22 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:22 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:22 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:22 INFO: Storing value log head: {Fid:0 Len:29 Offset:52} +badger 2024/12/06 15:41:22 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:22 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.073515ms +badger 2024/12/06 15:41:22 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:22 INFO: Force compaction on level 0 done +--- PASS: TestServer_GetVhosts (0.15s) === RUN TestServer_RealStart -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:22 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:24 INFO: Storing value log head: {Fid:0 Len:29 Offset:119} -badger 2026/01/07 19:59:24 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:24 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 2.794207ms -badger 2026/01/07 19:59:24 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:24 INFO: Force compaction on level 0 done ---- PASS: TestServer_RealStart (2.02s) +badger 2024/12/06 15:41:22 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:23 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:23 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:24 INFO: Storing value log head: {Fid:0 Len:29 Offset:119} +badger 2024/12/06 15:41:24 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:24 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 9.558801ms +badger 2024/12/06 15:41:24 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:24 INFO: Force compaction on level 0 done +--- PASS: TestServer_RealStart (2.05s) === RUN TestServer_WrongProtocol -badger 2026/01/07 19:59:24 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:24 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:24 INFO: All 0 tables opened in 0s -badger 2026/01/07 19:59:26 INFO: Storing value log head: {Fid:0 Len:29 Offset:119} -badger 2026/01/07 19:59:26 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 -badger 2026/01/07 19:59:26 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 3.774881ms -badger 2026/01/07 19:59:26 INFO: [Compactor: 173] Compaction for level: 0 DONE -badger 2026/01/07 19:59:26 INFO: Force compaction on level 0 done ---- PASS: TestServer_WrongProtocol (2.03s) +badger 2024/12/06 15:41:25 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:25 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:25 INFO: All 0 tables opened in 0s +badger 2024/12/06 15:41:27 INFO: Storing value log head: {Fid:0 Len:29 Offset:119} +badger 2024/12/06 15:41:27 INFO: [Compactor: 173] Running compaction: {level:0 score:1.73 dropPrefixes:[]} for level: 0 +badger 2024/12/06 15:41:27 INFO: LOG Compact 0->1, del 1 tables, add 1 tables, took 7.518168ms +badger 2024/12/06 15:41:27 INFO: [Compactor: 173] Compaction for level: 0 DONE +badger 2024/12/06 15:41:27 INFO: Force compaction on level 0 done +--- PASS: TestServer_WrongProtocol (2.04s) PASS -ok github.com/valinurovam/garagemq/server 23.499s +ok github.com/valinurovam/garagemq/server 28.135s make[1]: Leaving directory '/build/reproducible-path/garagemq-0.0~git20200204.15e6a9d+ds' create-stamp debian/debhelper-build-stamp fakeroot debian/rules binary @@ -2204,12 +2240,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: not including original source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/975698/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/975698/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/489611 and its subdirectories -I: Current time: Wed Jan 7 19:59:39 -12 2026 -I: pbuilder-time-stamp: 1767859179 +I: removing directory /srv/workspace/pbuilder/975698 and its subdirectories +I: Current time: Fri Dec 6 15:41:45 +14 2024 +I: pbuilder-time-stamp: 1733449305