Diff of the two buildlogs: -- --- b1/build.log 2023-04-20 01:14:19.237828622 +0000 +++ b2/build.log 2023-04-20 01:15:44.878028263 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed Apr 19 13:11:25 -12 2023 -I: pbuilder-time-stamp: 1681953085 +I: Current time: Wed May 22 21:37:21 +14 2024 +I: pbuilder-time-stamp: 1716363441 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bookworm-reproducible-base.tgz] I: copying local configuration @@ -17,7 +17,7 @@ I: copying [./spymemcached_2.12.3+dfsg.orig.tar.xz] I: copying [./spymemcached_2.12.3+dfsg-3.debian.tar.xz] I: Extracting source -gpgv: Signature made Sun Feb 26 04:10:17 2023 -12 +gpgv: Signature made Mon Feb 27 06:10:17 2023 +14 gpgv: using RSA key 73B299CBD4EEADDCC017E87A5BFFDCC258E69433 gpgv: Can't check signature: No public key dpkg-source: warning: cannot verify inline signature for ./spymemcached_2.12.3+dfsg-3.dsc: no acceptable signature found @@ -28,137 +28,169 @@ dpkg-source: info: applying 0001-Disable-failing-tests-with-JDK-17.patch I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/18661/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/50499/tmp/hooks/D01_modify_environment starting +debug: Running on ionos6-i386. +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 May 22 21: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/50499/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/50499/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='i386' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=8' - DISTRIBUTION='bookworm' - HOME='/root' - HOST_ARCH='i386' + 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]="15" [3]="1" [4]="release" [5]="i686-pc-linux-gnu") + BASH_VERSION='5.2.15(1)-release' + BUILDDIR=/build + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=i386 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=15' + DIRSTACK=() + DISTRIBUTION=bookworm + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=i686 + HOST_ARCH=i386 IFS=' ' - INVOCATION_ID='c1b4f97ccf894fef901b2e2841ff2a62' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - LD_LIBRARY_PATH='/usr/lib/libeatmydata' - LD_PRELOAD='libeatmydata.so' - 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='18661' - PS1='# ' - PS2='> ' + INVOCATION_ID=0dc79945c9cf408fa7a302173e984715 + LANG=C + LANGUAGE=de_CH:de + LC_ALL=C + LD_LIBRARY_PATH=/usr/lib/libeatmydata + LD_PRELOAD=libeatmydata.so + MACHTYPE=i686-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=50499 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.UHr9cSEp/pbuilderrc_8Axr --distribution bookworm --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bookworm-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.UHr9cSEp/b1 --logfile b1/build.log spymemcached_2.12.3+dfsg-3.dsc' - SUDO_GID='112' - SUDO_UID='107' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://78.137.99.97: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.UHr9cSEp/pbuilderrc_BQV4 --distribution bookworm --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bookworm-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.UHr9cSEp/b2 --logfile b2/build.log --extrapackages usrmerge spymemcached_2.12.3+dfsg-3.dsc' + SUDO_GID=112 + SUDO_UID=107 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://85.184.249.68:3128 I: uname -a - Linux ionos12-i386 5.10.0-21-686-pae #1 SMP Debian 5.10.162-1 (2023-01-21) i686 GNU/Linux + Linux i-capture-the-hostname 5.10.0-21-amd64 #1 SMP Debian 5.10.162-1 (2023-01-21) x86_64 GNU/Linux I: ls -l /bin total 6036 - -rwxr-xr-x 1 root root 1408088 Feb 12 08:21 bash - -rwxr-xr-x 3 root root 38404 Sep 18 2022 bunzip2 - -rwxr-xr-x 3 root root 38404 Sep 18 2022 bzcat - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzcmp -> bzdiff - -rwxr-xr-x 1 root root 2225 Sep 18 2022 bzdiff - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzegrep -> bzgrep - -rwxr-xr-x 1 root root 4893 Nov 27 2021 bzexe - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzfgrep -> bzgrep - -rwxr-xr-x 1 root root 3775 Sep 18 2022 bzgrep - -rwxr-xr-x 3 root root 38404 Sep 18 2022 bzip2 - -rwxr-xr-x 1 root root 17892 Sep 18 2022 bzip2recover - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzless -> bzmore - -rwxr-xr-x 1 root root 1297 Sep 18 2022 bzmore - -rwxr-xr-x 1 root root 42920 Sep 20 2022 cat - -rwxr-xr-x 1 root root 79816 Sep 20 2022 chgrp - -rwxr-xr-x 1 root root 67496 Sep 20 2022 chmod - -rwxr-xr-x 1 root root 79816 Sep 20 2022 chown - -rwxr-xr-x 1 root root 162024 Sep 20 2022 cp - -rwxr-xr-x 1 root root 136916 Jan 5 01:20 dash - -rwxr-xr-x 1 root root 137160 Sep 20 2022 date - -rwxr-xr-x 1 root root 100364 Sep 20 2022 dd - -rwxr-xr-x 1 root root 108940 Sep 20 2022 df - -rwxr-xr-x 1 root root 162152 Sep 20 2022 dir - -rwxr-xr-x 1 root root 87760 Mar 22 22:20 dmesg - lrwxrwxrwx 1 root root 8 Dec 19 01:33 dnsdomainname -> hostname - lrwxrwxrwx 1 root root 8 Dec 19 01:33 domainname -> hostname - -rwxr-xr-x 1 root root 38760 Sep 20 2022 echo - -rwxr-xr-x 1 root root 41 Jan 24 02:43 egrep - -rwxr-xr-x 1 root root 34664 Sep 20 2022 false - -rwxr-xr-x 1 root root 41 Jan 24 02:43 fgrep - -rwxr-xr-x 1 root root 84272 Mar 22 22:20 findmnt - -rwsr-xr-x 1 root root 30240 Mar 22 20:38 fusermount - -rwxr-xr-x 1 root root 218680 Jan 24 02:43 grep - -rwxr-xr-x 2 root root 2346 Apr 9 2022 gunzip - -rwxr-xr-x 1 root root 6447 Apr 9 2022 gzexe - -rwxr-xr-x 1 root root 100952 Apr 9 2022 gzip - -rwxr-xr-x 1 root root 21916 Dec 19 01:33 hostname - -rwxr-xr-x 1 root root 75756 Sep 20 2022 ln - -rwxr-xr-x 1 root root 55600 Mar 22 23:43 login - -rwxr-xr-x 1 root root 162152 Sep 20 2022 ls - -rwxr-xr-x 1 root root 214568 Mar 22 22:20 lsblk - -rwxr-xr-x 1 root root 96328 Sep 20 2022 mkdir - -rwxr-xr-x 1 root root 84008 Sep 20 2022 mknod - -rwxr-xr-x 1 root root 38792 Sep 20 2022 mktemp - -rwxr-xr-x 1 root root 63016 Mar 22 22:20 more - -rwsr-xr-x 1 root root 58912 Mar 22 22:20 mount - -rwxr-xr-x 1 root root 13856 Mar 22 22:20 mountpoint - -rwxr-xr-x 1 root root 157932 Sep 20 2022 mv - lrwxrwxrwx 1 root root 8 Dec 19 01:33 nisdomainname -> hostname - lrwxrwxrwx 1 root root 14 Apr 2 18:25 pidof -> /sbin/killall5 - -rwxr-xr-x 1 root root 38792 Sep 20 2022 pwd - lrwxrwxrwx 1 root root 4 Feb 12 08:21 rbash -> bash - -rwxr-xr-x 1 root root 51080 Sep 20 2022 readlink - -rwxr-xr-x 1 root root 75720 Sep 20 2022 rm - -rwxr-xr-x 1 root root 51080 Sep 20 2022 rmdir - -rwxr-xr-x 1 root root 22308 Nov 2 04:31 run-parts - -rwxr-xr-x 1 root root 133224 Jan 5 07:55 sed - lrwxrwxrwx 1 root root 4 Jan 5 01:20 sh -> dash - -rwxr-xr-x 1 root root 38760 Sep 20 2022 sleep - -rwxr-xr-x 1 root root 87976 Sep 20 2022 stty - -rwsr-xr-x 1 root root 83492 Mar 22 22:20 su - -rwxr-xr-x 1 root root 38792 Sep 20 2022 sync - -rwxr-xr-x 1 root root 598456 Apr 6 02:25 tar - -rwxr-xr-x 1 root root 13860 Nov 2 04:31 tempfile - -rwxr-xr-x 1 root root 120776 Sep 20 2022 touch - -rwxr-xr-x 1 root root 34664 Sep 20 2022 true - -rwxr-xr-x 1 root root 17892 Mar 22 20:38 ulockmgr_server - -rwsr-xr-x 1 root root 30236 Mar 22 22:20 umount - -rwxr-xr-x 1 root root 38760 Sep 20 2022 uname - -rwxr-xr-x 2 root root 2346 Apr 9 2022 uncompress - -rwxr-xr-x 1 root root 162152 Sep 20 2022 vdir - -rwxr-xr-x 1 root root 71216 Mar 22 22:20 wdctl - lrwxrwxrwx 1 root root 8 Dec 19 01:33 ypdomainname -> hostname - -rwxr-xr-x 1 root root 1984 Apr 9 2022 zcat - -rwxr-xr-x 1 root root 1678 Apr 9 2022 zcmp - -rwxr-xr-x 1 root root 6460 Apr 9 2022 zdiff - -rwxr-xr-x 1 root root 29 Apr 9 2022 zegrep - -rwxr-xr-x 1 root root 29 Apr 9 2022 zfgrep - -rwxr-xr-x 1 root root 2081 Apr 9 2022 zforce - -rwxr-xr-x 1 root root 8103 Apr 9 2022 zgrep - -rwxr-xr-x 1 root root 2206 Apr 9 2022 zless - -rwxr-xr-x 1 root root 1842 Apr 9 2022 zmore - -rwxr-xr-x 1 root root 4577 Apr 9 2022 znew -I: user script /srv/workspace/pbuilder/18661/tmp/hooks/D02_print_environment finished + -rwxr-xr-x 1 root root 1408088 Feb 13 2023 bash + -rwxr-xr-x 3 root root 38404 Sep 19 2022 bunzip2 + -rwxr-xr-x 3 root root 38404 Sep 19 2022 bzcat + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzcmp -> bzdiff + -rwxr-xr-x 1 root root 2225 Sep 19 2022 bzdiff + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzegrep -> bzgrep + -rwxr-xr-x 1 root root 4893 Nov 28 2021 bzexe + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzfgrep -> bzgrep + -rwxr-xr-x 1 root root 3775 Sep 19 2022 bzgrep + -rwxr-xr-x 3 root root 38404 Sep 19 2022 bzip2 + -rwxr-xr-x 1 root root 17892 Sep 19 2022 bzip2recover + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzless -> bzmore + -rwxr-xr-x 1 root root 1297 Sep 19 2022 bzmore + -rwxr-xr-x 1 root root 42920 Sep 21 2022 cat + -rwxr-xr-x 1 root root 79816 Sep 21 2022 chgrp + -rwxr-xr-x 1 root root 67496 Sep 21 2022 chmod + -rwxr-xr-x 1 root root 79816 Sep 21 2022 chown + -rwxr-xr-x 1 root root 162024 Sep 21 2022 cp + -rwxr-xr-x 1 root root 136916 Jan 6 2023 dash + -rwxr-xr-x 1 root root 137160 Sep 21 2022 date + -rwxr-xr-x 1 root root 100364 Sep 21 2022 dd + -rwxr-xr-x 1 root root 108940 Sep 21 2022 df + -rwxr-xr-x 1 root root 162152 Sep 21 2022 dir + -rwxr-xr-x 1 root root 87760 Mar 24 2023 dmesg + lrwxrwxrwx 1 root root 8 Dec 20 2022 dnsdomainname -> hostname + lrwxrwxrwx 1 root root 8 Dec 20 2022 domainname -> hostname + -rwxr-xr-x 1 root root 38760 Sep 21 2022 echo + -rwxr-xr-x 1 root root 41 Jan 25 2023 egrep + -rwxr-xr-x 1 root root 34664 Sep 21 2022 false + -rwxr-xr-x 1 root root 41 Jan 25 2023 fgrep + -rwxr-xr-x 1 root root 84272 Mar 24 2023 findmnt + -rwsr-xr-x 1 root root 30240 Mar 23 2023 fusermount + -rwxr-xr-x 1 root root 218680 Jan 25 2023 grep + -rwxr-xr-x 2 root root 2346 Apr 10 2022 gunzip + -rwxr-xr-x 1 root root 6447 Apr 10 2022 gzexe + -rwxr-xr-x 1 root root 100952 Apr 10 2022 gzip + -rwxr-xr-x 1 root root 21916 Dec 20 2022 hostname + -rwxr-xr-x 1 root root 75756 Sep 21 2022 ln + -rwxr-xr-x 1 root root 55600 Mar 24 2023 login + -rwxr-xr-x 1 root root 162152 Sep 21 2022 ls + -rwxr-xr-x 1 root root 214568 Mar 24 2023 lsblk + -rwxr-xr-x 1 root root 96328 Sep 21 2022 mkdir + -rwxr-xr-x 1 root root 84008 Sep 21 2022 mknod + -rwxr-xr-x 1 root root 38792 Sep 21 2022 mktemp + -rwxr-xr-x 1 root root 63016 Mar 24 2023 more + -rwsr-xr-x 1 root root 58912 Mar 24 2023 mount + -rwxr-xr-x 1 root root 13856 Mar 24 2023 mountpoint + -rwxr-xr-x 1 root root 157932 Sep 21 2022 mv + lrwxrwxrwx 1 root root 8 Dec 20 2022 nisdomainname -> hostname + lrwxrwxrwx 1 root root 14 Apr 3 2023 pidof -> /sbin/killall5 + -rwxr-xr-x 1 root root 38792 Sep 21 2022 pwd + lrwxrwxrwx 1 root root 4 Feb 13 2023 rbash -> bash + -rwxr-xr-x 1 root root 51080 Sep 21 2022 readlink + -rwxr-xr-x 1 root root 75720 Sep 21 2022 rm + -rwxr-xr-x 1 root root 51080 Sep 21 2022 rmdir + -rwxr-xr-x 1 root root 22308 Nov 3 2022 run-parts + -rwxr-xr-x 1 root root 133224 Jan 6 2023 sed + lrwxrwxrwx 1 root root 9 May 22 21:37 sh -> /bin/bash + -rwxr-xr-x 1 root root 38760 Sep 21 2022 sleep + -rwxr-xr-x 1 root root 87976 Sep 21 2022 stty + -rwsr-xr-x 1 root root 83492 Mar 24 2023 su + -rwxr-xr-x 1 root root 38792 Sep 21 2022 sync + -rwxr-xr-x 1 root root 598456 Apr 7 2023 tar + -rwxr-xr-x 1 root root 13860 Nov 3 2022 tempfile + -rwxr-xr-x 1 root root 120776 Sep 21 2022 touch + -rwxr-xr-x 1 root root 34664 Sep 21 2022 true + -rwxr-xr-x 1 root root 17892 Mar 23 2023 ulockmgr_server + -rwsr-xr-x 1 root root 30236 Mar 24 2023 umount + -rwxr-xr-x 1 root root 38760 Sep 21 2022 uname + -rwxr-xr-x 2 root root 2346 Apr 10 2022 uncompress + -rwxr-xr-x 1 root root 162152 Sep 21 2022 vdir + -rwxr-xr-x 1 root root 71216 Mar 24 2023 wdctl + lrwxrwxrwx 1 root root 8 Dec 20 2022 ypdomainname -> hostname + -rwxr-xr-x 1 root root 1984 Apr 10 2022 zcat + -rwxr-xr-x 1 root root 1678 Apr 10 2022 zcmp + -rwxr-xr-x 1 root root 6460 Apr 10 2022 zdiff + -rwxr-xr-x 1 root root 29 Apr 10 2022 zegrep + -rwxr-xr-x 1 root root 29 Apr 10 2022 zfgrep + -rwxr-xr-x 1 root root 2081 Apr 10 2022 zforce + -rwxr-xr-x 1 root root 8103 Apr 10 2022 zgrep + -rwxr-xr-x 1 root root 2206 Apr 10 2022 zless + -rwxr-xr-x 1 root root 1842 Apr 10 2022 zmore + -rwxr-xr-x 1 root root 4577 Apr 10 2022 znew +I: user script /srv/workspace/pbuilder/50499/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -487,7 +519,7 @@ Get: 271 http://deb.debian.org/debian bookworm/main i386 maven-repo-helper all 1.11 [142 kB] Get: 272 http://deb.debian.org/debian bookworm/main i386 maven-debian-helper all 2.6.2 [108 kB] Get: 273 http://deb.debian.org/debian bookworm/main i386 net-tools i386 2.10-0.1 [245 kB] -Fetched 505 MB in 10s (49.6 MB/s) +Fetched 505 MB in 6s (83.1 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package libevent-2.1-7:i386. (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 ... 19604 files and directories currently installed.) @@ -1782,8 +1814,19 @@ Writing extended state information... Building tag database... -> Finished parsing the build-deps +Reading package lists... +Building dependency tree... +Reading state information... +usrmerge is already the newest version (35). +0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. I: Building the package -I: Running cd /build/spymemcached-2.12.3+dfsg/ && 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 > ../spymemcached_2.12.3+dfsg-3_source.changes +I: user script /srv/workspace/pbuilder/50499/tmp/hooks/A99_set_merged_usr starting +Re-configuring usrmerge... +removed '/etc/unsupported-skip-usrmerge-conversion' +The system has been successfully converted. +I: user script /srv/workspace/pbuilder/50499/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/spymemcached-2.12.3+dfsg/ && 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 > ../spymemcached_2.12.3+dfsg-3_source.changes dpkg-buildpackage: info: source package spymemcached dpkg-buildpackage: info: source version 2.12.3+dfsg-3 dpkg-buildpackage: info: source distribution unstable @@ -1854,13 +1897,13 @@ [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ -[INFO] Total time: 12.075 s -[INFO] Finished at: 2023-04-19T13:13:19-12:00 +[INFO] Total time: 4.186 s +[INFO] Finished at: 2024-05-22T21:38:16+14:00 [INFO] ------------------------------------------------------------------------  debian/rules override_dh_auto_test make[1]: Entering directory '/build/spymemcached-2.12.3+dfsg' mkdir -p /build/spymemcached-2.12.3+dfsg/debian/build -memcached -u pbuilder1 -p 20000 -P /build/spymemcached-2.12.3+dfsg/debian/build/memcached.pid -d +memcached -u pbuilder2 -p 20000 -P /build/spymemcached-2.12.3+dfsg/debian/build/memcached.pid -d export SPY_MC_TEST_SERVER=localhost:20000 SPYMC_TEST_SERVER_V4=localhost:20000 SPYMC_TEST_SERVER_v6=::1:20000;\ dh_auto_test -- -Dserver.port_number=20000 -Dtest.type=ci test /usr/lib/jvm/default-java/bin/java -noverify -cp /usr/share/maven/boot/plexus-classworlds-2.x.jar -Dmaven.home=/usr/share/maven -Dmaven.multiModuleProjectDirectory=/build/spymemcached-2.12.3\+dfsg -Dclassworlds.conf=/etc/maven/m2-debian.conf -Dproperties.file.manual=/build/spymemcached-2.12.3\+dfsg/debian/maven.properties org.codehaus.plexus.classworlds.launcher.Launcher -s/etc/maven/settings-debian.xml -Ddebian.dir=/build/spymemcached-2.12.3\+dfsg/debian -Dmaven.repo.local=/build/spymemcached-2.12.3\+dfsg/debian/maven-repo --batch-mode -Dserver.port_number=20000 -Dtest.type=ci test @@ -1891,22 +1934,19 @@ [INFO] ------------------------------------------------------- [INFO] T E S T S [INFO] ------------------------------------------------------- -[INFO] Running net.spy.memcached.transcoders.LongTranscoderTest -2023-04-19 13:13:25.418 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 769 wanted 768 -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.111 s - in net.spy.memcached.transcoders.LongTranscoderTest +[INFO] Running net.spy.memcached.transcoders.TranscoderUtilsTest +[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.015 s - in net.spy.memcached.transcoders.TranscoderUtilsTest [INFO] Running net.spy.memcached.transcoders.CachedDataTest -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.transcoders.CachedDataTest -[INFO] Running net.spy.memcached.transcoders.TranscodeServiceTest -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.transcoders.TranscodeServiceTest -[INFO] Running net.spy.memcached.transcoders.SerializingTranscoderTest -2023-04-19 13:13:25.665 INFO net.spy.memcached.transcoders.SerializingTranscoder: Compression increased the size of java.lang.String from 57 to 73 -2023-04-19 13:13:25.704 WARN net.spy.memcached.transcoders.SerializingTranscoder: Caught IOException decoding 4 bytes of data +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.transcoders.CachedDataTest +[INFO] Running net.spy.memcached.transcoders.WhalinTranscoderTest +2024-05-22 21:38:18.743 INFO net.spy.memcached.transcoders.WhalinTranscoder: Compression increased the size of java.lang.String from 57 to 73 +2024-05-22 21:38:18.762 WARN net.spy.memcached.transcoders.WhalinTranscoder: Caught IOException decoding 4 bytes of data java.io.StreamCorruptedException: invalid stream header: 7FFFFFFF at java.base/java.io.ObjectInputStream.readStreamHeader(ObjectInputStream.java:958) at java.base/java.io.ObjectInputStream.(ObjectInputStream.java:392) at net.spy.memcached.transcoders.BaseSerializingTranscoder.deserialize(BaseSerializingTranscoder.java:128) - at net.spy.memcached.transcoders.SerializingTranscoder.decode(SerializingTranscoder.java:88) - at net.spy.memcached.transcoders.SerializingTranscoderTest.testUndecodeableSerialized(SerializingTranscoderTest.java:125) + at net.spy.memcached.transcoders.WhalinTranscoder.decode(WhalinTranscoder.java:70) + at net.spy.memcached.transcoders.WhalinTranscoderTest.testUndecodeableSerialized(WhalinTranscoderTest.java:124) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) @@ -1928,14 +1968,14 @@ at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) -2023-04-19 13:13:25.707 WARN net.spy.memcached.transcoders.SerializingTranscoder: Failed to decompress data +2024-05-22 21:38:18.765 WARN net.spy.memcached.transcoders.WhalinTranscoder: Failed to decompress data java.util.zip.ZipException: Not in GZIP format at java.base/java.util.zip.GZIPInputStream.readHeader(GZIPInputStream.java:165) at java.base/java.util.zip.GZIPInputStream.(GZIPInputStream.java:79) at java.base/java.util.zip.GZIPInputStream.(GZIPInputStream.java:91) at net.spy.memcached.transcoders.BaseSerializingTranscoder.decompress(BaseSerializingTranscoder.java:181) - at net.spy.memcached.transcoders.SerializingTranscoder.decode(SerializingTranscoder.java:84) - at net.spy.memcached.transcoders.SerializingTranscoderTest.testUndecodeableCompressed(SerializingTranscoderTest.java:132) + at net.spy.memcached.transcoders.WhalinTranscoder.decode(WhalinTranscoder.java:67) + at net.spy.memcached.transcoders.WhalinTranscoderTest.testUndecodeableCompressed(WhalinTranscoderTest.java:130) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) @@ -1957,21 +1997,41 @@ at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) -got null -2023-04-19 13:13:25.710 WARN net.spy.memcached.transcoders.SerializingTranscoder: Failed to decompress data -java.util.zip.ZipException: Not in GZIP format - at java.base/java.util.zip.GZIPInputStream.readHeader(GZIPInputStream.java:165) - at java.base/java.util.zip.GZIPInputStream.(GZIPInputStream.java:79) - at java.base/java.util.zip.GZIPInputStream.(GZIPInputStream.java:91) - at net.spy.memcached.transcoders.BaseSerializingTranscoder.decompress(BaseSerializingTranscoder.java:181) - at net.spy.memcached.transcoders.SerializingTranscoder.decode(SerializingTranscoder.java:84) - at net.spy.memcached.transcoders.SerializingTranscoderTest.testUndecodeableCompressed(SerializingTranscoderTest.java:133) +2024-05-22 21:38:18.768 WARN net.spy.memcached.transcoders.WhalinTranscoder: Cannot handle data with flags 0 +2024-05-22 21:38:18.771 WARN net.spy.memcached.transcoders.WhalinTranscoder: Cannot handle data with flags 7ffffff5 +[INFO] Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.109 s - in net.spy.memcached.transcoders.WhalinTranscoderTest +[INFO] Running net.spy.memcached.transcoders.TranscodeServiceTest +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.transcoders.TranscodeServiceTest +[INFO] Running net.spy.memcached.transcoders.LongTranscoderTest +2024-05-22 21:38:18.805 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 769 wanted 768 +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.transcoders.LongTranscoderTest +[INFO] Running net.spy.memcached.transcoders.WhalinV1TranscoderTest +2024-05-22 21:38:18.816 INFO net.spy.memcached.transcoders.WhalinV1Transcoder: Compressed java.util.ArrayList from 17491 to 199 +[INFO] Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.014 s - in net.spy.memcached.transcoders.WhalinV1TranscoderTest +[INFO] Running net.spy.memcached.transcoders.BaseSerializingTranscoderTest +2024-05-22 21:38:18.826 WARN net.spy.memcached.transcoders.BaseSerializingTranscoderTest$Exposer: Caught CNFE decoding 41 bytes of data +java.lang.ClassNotFoundException: Test + at java.base/jdk.internal.loader.BuiltinClassLoader.loadClass(BuiltinClassLoader.java:641) + at java.base/jdk.internal.loader.ClassLoaders$AppClassLoader.loadClass(ClassLoaders.java:188) + at java.base/java.lang.ClassLoader.loadClass(ClassLoader.java:520) + at java.base/java.lang.Class.forName0(Native Method) + at java.base/java.lang.Class.forName(Class.java:467) + at java.base/java.io.ObjectInputStream.resolveClass(ObjectInputStream.java:773) + at java.base/java.io.ObjectInputStream.readNonProxyDesc(ObjectInputStream.java:2034) + at java.base/java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1898) + at java.base/java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2224) + at java.base/java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1733) + at java.base/java.io.ObjectInputStream.readObject(ObjectInputStream.java:509) + at java.base/java.io.ObjectInputStream.readObject(ObjectInputStream.java:467) + at net.spy.memcached.transcoders.BaseSerializingTranscoder.deserialize(BaseSerializingTranscoder.java:129) + at net.spy.memcached.transcoders.BaseSerializingTranscoderTest$Exposer.deserialize(BaseSerializingTranscoderTest.java:154) + at net.spy.memcached.transcoders.BaseSerializingTranscoderTest.testUndeserializable(BaseSerializingTranscoderTest.java:98) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:568) at junit.framework.TestCase.runTest(TestCase.java:177) - at org.jmock.core.VerifyingTestCase.runBare(VerifyingTestCase.java:39) + at junit.framework.TestCase.runBare(TestCase.java:142) at junit.framework.TestResult$1.protect(TestResult.java:122) at junit.framework.TestResult.runProtected(TestResult.java:142) at junit.framework.TestResult.run(TestResult.java:125) @@ -1987,21 +2047,16 @@ at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) -2023-04-19 13:13:25.724 WARN net.spy.memcached.transcoders.SerializingTranscoder: Undecodeable with flags ff00 -[INFO] Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.288 s - in net.spy.memcached.transcoders.SerializingTranscoderTest -[INFO] Running net.spy.memcached.transcoders.IntegerTranscoderTest -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007 s - in net.spy.memcached.transcoders.IntegerTranscoderTest -[INFO] Running net.spy.memcached.transcoders.TranscoderUtilsTest -[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.009 s - in net.spy.memcached.transcoders.TranscoderUtilsTest -[INFO] Running net.spy.memcached.transcoders.WhalinTranscoderTest -2023-04-19 13:13:25.851 INFO net.spy.memcached.transcoders.WhalinTranscoder: Compression increased the size of java.lang.String from 57 to 73 -2023-04-19 13:13:25.857 WARN net.spy.memcached.transcoders.WhalinTranscoder: Caught IOException decoding 4 bytes of data +[INFO] Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.015 s - in net.spy.memcached.transcoders.BaseSerializingTranscoderTest +[INFO] Running net.spy.memcached.transcoders.SerializingTranscoderTest +2024-05-22 21:38:18.847 INFO net.spy.memcached.transcoders.SerializingTranscoder: Compression increased the size of java.lang.String from 57 to 73 +2024-05-22 21:38:18.850 WARN net.spy.memcached.transcoders.SerializingTranscoder: Caught IOException decoding 4 bytes of data java.io.StreamCorruptedException: invalid stream header: 7FFFFFFF at java.base/java.io.ObjectInputStream.readStreamHeader(ObjectInputStream.java:958) at java.base/java.io.ObjectInputStream.(ObjectInputStream.java:392) at net.spy.memcached.transcoders.BaseSerializingTranscoder.deserialize(BaseSerializingTranscoder.java:128) - at net.spy.memcached.transcoders.WhalinTranscoder.decode(WhalinTranscoder.java:70) - at net.spy.memcached.transcoders.WhalinTranscoderTest.testUndecodeableSerialized(WhalinTranscoderTest.java:124) + at net.spy.memcached.transcoders.SerializingTranscoder.decode(SerializingTranscoder.java:88) + at net.spy.memcached.transcoders.SerializingTranscoderTest.testUndecodeableSerialized(SerializingTranscoderTest.java:125) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) @@ -2023,14 +2078,14 @@ at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) -2023-04-19 13:13:25.860 WARN net.spy.memcached.transcoders.WhalinTranscoder: Failed to decompress data +2024-05-22 21:38:18.851 WARN net.spy.memcached.transcoders.SerializingTranscoder: Failed to decompress data java.util.zip.ZipException: Not in GZIP format at java.base/java.util.zip.GZIPInputStream.readHeader(GZIPInputStream.java:165) at java.base/java.util.zip.GZIPInputStream.(GZIPInputStream.java:79) at java.base/java.util.zip.GZIPInputStream.(GZIPInputStream.java:91) at net.spy.memcached.transcoders.BaseSerializingTranscoder.decompress(BaseSerializingTranscoder.java:181) - at net.spy.memcached.transcoders.WhalinTranscoder.decode(WhalinTranscoder.java:67) - at net.spy.memcached.transcoders.WhalinTranscoderTest.testUndecodeableCompressed(WhalinTranscoderTest.java:130) + at net.spy.memcached.transcoders.SerializingTranscoder.decode(SerializingTranscoder.java:84) + at net.spy.memcached.transcoders.SerializingTranscoderTest.testUndecodeableCompressed(SerializingTranscoderTest.java:132) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) @@ -2052,33 +2107,21 @@ at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) -2023-04-19 13:13:25.863 WARN net.spy.memcached.transcoders.WhalinTranscoder: Cannot handle data with flags 0 -2023-04-19 13:13:25.865 WARN net.spy.memcached.transcoders.WhalinTranscoder: Cannot handle data with flags 7ffffff5 -[INFO] Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 s - in net.spy.memcached.transcoders.WhalinTranscoderTest -[INFO] Running net.spy.memcached.transcoders.BaseSerializingTranscoderTest -2023-04-19 13:13:25.927 WARN net.spy.memcached.transcoders.BaseSerializingTranscoderTest$Exposer: Caught CNFE decoding 41 bytes of data -java.lang.ClassNotFoundException: Test - at java.base/jdk.internal.loader.BuiltinClassLoader.loadClass(BuiltinClassLoader.java:641) - at java.base/jdk.internal.loader.ClassLoaders$AppClassLoader.loadClass(ClassLoaders.java:188) - at java.base/java.lang.ClassLoader.loadClass(ClassLoader.java:520) - at java.base/java.lang.Class.forName0(Native Method) - at java.base/java.lang.Class.forName(Class.java:467) - at java.base/java.io.ObjectInputStream.resolveClass(ObjectInputStream.java:773) - at java.base/java.io.ObjectInputStream.readNonProxyDesc(ObjectInputStream.java:2034) - at java.base/java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1898) - at java.base/java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2224) - at java.base/java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1733) - at java.base/java.io.ObjectInputStream.readObject(ObjectInputStream.java:509) - at java.base/java.io.ObjectInputStream.readObject(ObjectInputStream.java:467) - at net.spy.memcached.transcoders.BaseSerializingTranscoder.deserialize(BaseSerializingTranscoder.java:129) - at net.spy.memcached.transcoders.BaseSerializingTranscoderTest$Exposer.deserialize(BaseSerializingTranscoderTest.java:154) - at net.spy.memcached.transcoders.BaseSerializingTranscoderTest.testUndeserializable(BaseSerializingTranscoderTest.java:98) +got null +2024-05-22 21:38:18.852 WARN net.spy.memcached.transcoders.SerializingTranscoder: Failed to decompress data +java.util.zip.ZipException: Not in GZIP format + at java.base/java.util.zip.GZIPInputStream.readHeader(GZIPInputStream.java:165) + at java.base/java.util.zip.GZIPInputStream.(GZIPInputStream.java:79) + at java.base/java.util.zip.GZIPInputStream.(GZIPInputStream.java:91) + at net.spy.memcached.transcoders.BaseSerializingTranscoder.decompress(BaseSerializingTranscoder.java:181) + at net.spy.memcached.transcoders.SerializingTranscoder.decode(SerializingTranscoder.java:84) + at net.spy.memcached.transcoders.SerializingTranscoderTest.testUndecodeableCompressed(SerializingTranscoderTest.java:133) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:568) at junit.framework.TestCase.runTest(TestCase.java:177) - at junit.framework.TestCase.runBare(TestCase.java:142) + at org.jmock.core.VerifyingTestCase.runBare(VerifyingTestCase.java:39) at junit.framework.TestResult$1.protect(TestResult.java:122) at junit.framework.TestResult.runProtected(TestResult.java:142) at junit.framework.TestResult.run(TestResult.java:125) @@ -2094,84 +2137,20 @@ at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) -[INFO] Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.05 s - in net.spy.memcached.transcoders.BaseSerializingTranscoderTest -[INFO] Running net.spy.memcached.transcoders.WhalinV1TranscoderTest -2023-04-19 13:13:26.004 INFO net.spy.memcached.transcoders.WhalinV1Transcoder: Compressed java.util.ArrayList from 17491 to 196 -[INFO] Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.017 s - in net.spy.memcached.transcoders.WhalinV1TranscoderTest -[INFO] Running net.spy.memcached.LongClientTest -2023-04-19 13:13:26.077 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:26.106 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:26.129 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:26.130 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:26.132 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:26.143 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for k0. -2023-04-19 13:13:26.145 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for k1. -2023-04-19 13:13:26.146 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for k2. -2023-04-19 13:13:26.146 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for k3. -2023-04-19 13:13:26.148 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for k4. -2023-04-19 13:13:27.571 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.572 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.573 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.57 s - in net.spy.memcached.LongClientTest -[INFO] Running net.spy.memcached.AsciiCancellationTest -2023-04-19 13:13:27.611 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.623 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.624 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.643 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.648 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.649 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.668 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: get Keys: k2 kExp: 0, toWrite=0, interested=0} -java.net.ConnectException: Connection refused - at java.base/sun.nio.ch.Net.pollConnect(Native Method) - at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) - at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) - at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:27.669 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: get Keys: k2 kExp: 0, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:27.683 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.691 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.692 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.708 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.709 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.711 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.720 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} -java.net.ConnectException: Connection refused - at java.base/sun.nio.ch.Net.pollConnect(Native Method) - at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) - at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) - at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:27.720 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:27.747 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.748 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.749 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.756 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} -java.net.ConnectException: Connection refused - at java.base/sun.nio.ch.Net.pollConnect(Native Method) - at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) - at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) - at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:27.756 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:27.780 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.783 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.784 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.792 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} -java.net.ConnectException: Connection refused - at java.base/sun.nio.ch.Net.pollConnect(Native Method) - at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) - at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) - at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:27.792 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:27.812 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.813 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.820 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.832 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: flush_all Delay: 3, toWrite=0, interested=0} +2024-05-22 21:38:18.854 WARN net.spy.memcached.transcoders.SerializingTranscoder: Undecodeable with flags ff00 +[INFO] Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.022 s - in net.spy.memcached.transcoders.SerializingTranscoderTest +[INFO] Running net.spy.memcached.transcoders.IntegerTranscoderTest +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.transcoders.IntegerTranscoderTest +[INFO] Running net.spy.memcached.CacheMapTest +[INFO] Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.028 s - in net.spy.memcached.CacheMapTest +[INFO] Running net.spy.memcached.util.CacheLoaderTest +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.252 s - in net.spy.memcached.util.CacheLoaderTest +[INFO] Running net.spy.memcached.util.StringUtilsTest +[INFO] Tests run: 16, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.019 s - in net.spy.memcached.util.StringUtilsTest +[INFO] Running net.spy.memcached.BinaryCancellationTest +2024-05-22 21:38:19.194 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.201 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.203 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2179,11 +2158,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:27.832 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: flush_all Delay: 3, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:27.847 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.848 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.848 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.856 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} +2024-05-22 21:38:19.204 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.205 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.206 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.206 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.207 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2191,11 +2170,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:27.856 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:27.879 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.880 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.880 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.888 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} +2024-05-22 21:38:19.207 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.225 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.225 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.226 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.226 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2203,11 +2182,10 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:27.888 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:27.915 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.920 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.920 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.932 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: set Key: x Flags: 0 Exp: 3 Data Length: 1, toWrite=0, interested=0} +2024-05-22 21:38:19.226 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.227 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.227 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.227 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2215,11 +2193,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:27.932 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: set Key: x Flags: 0 Exp: 3 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:27.952 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.953 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:27.955 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.972 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: get Keys: k2 kExp: 0, toWrite=0, interested=0} +2024-05-22 21:38:19.227 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.238 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.238 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.238 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.239 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2227,11 +2205,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:27.972 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: get Keys: k2 kExp: 0, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:27.983 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:27.988 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:27.988 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:28.008 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: replace Key: x Flags: 0 Exp: 3 Data Length: 1, toWrite=0, interested=0} +2024-05-22 21:38:19.239 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.250 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.251 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.251 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.251 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2239,11 +2217,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:28.008 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: replace Key: x Flags: 0 Exp: 3 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:28.023 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:28.031 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:28.032 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:28.048 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: get Keys: kExp: 0, toWrite=0, interested=0} +2024-05-22 21:38:19.252 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.263 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.264 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.264 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.265 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2251,83 +2229,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:28.048 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: get Keys: kExp: 0, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:28.063[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.45 s - in net.spy.memcached.AsciiCancellationTest -[INFO] Running net.spy.memcached.RedistributeFailureModeTest - INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:28.071 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:28.072 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:28.072 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:11311, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:28.088 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:11311, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} -java.net.ConnectException: Connection refused - at java.base/sun.nio.ch.Net.pollConnect(Native Method) - at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) - at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) - at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:28.088 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:11311, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -testMixedSetsAndUpdates complete. -2023-04-19 13:13:28.218 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:28.218 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:28.219 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:28.363 INFO net.spy.memcached.MemcachedConnection[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.29 s - in net.spy.memcached.RedistributeFailureModeTest -[INFO] Running net.spy.memcached.tapmessage.ResponseMessageWrongOrderTest -: Shut down memcached client -[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.135 s - in net.spy.memcached.tapmessage.ResponseMessageWrongOrderTest -[INFO] Running net.spy.memcached.tapmessage.TapDeleteTest -[INFO] Tests run: 14, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.tapmessage.TapDeleteTest -[INFO] Running net.spy.memcached.tapmessage.ResponseMessageFixedOrderTest -[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.tapmessage.ResponseMessageFixedOrderTest -[INFO] Running net.spy.memcached.ToStringTest -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.ToStringTest -[INFO] Running net.spy.memcached.ArrayModNodeLocatorTest -[INFO] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.069 s - in net.spy.memcached.ArrayModNodeLocatorTest -[INFO] Running net.spy.memcached.KetamaNodeKeyFormatterTest -[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.KetamaNodeKeyFormatterTest -[INFO] Running net.spy.memcached.KetamaConnectionFactoryTest -[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.KetamaConnectionFactoryTest -[INFO] Running net.spy.memcached.protocol.binary.OperatonTest -[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.protocol.binary.OperatonTest -[INFO] Running net.spy.memcached.protocol.binary.OperationFactoryTest -[INFO] Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.073 s - in net.spy.memcached.protocol.binary.OperationFactoryTest -[INFO] Running net.spy.memcached.protocol.binary.BinaryToStringTest -[INFO] Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.037 s - in net.spy.memcached.protocol.binary.BinaryToStringTest -[INFO] Running net.spy.memcached.protocol.ascii.BaseOpTest -[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.protocol.ascii.BaseOpTest -[INFO] Running net.spy.memcached.protocol.ascii.OperationFactoryTest -[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 16.947 s - in net.spy.memcached.protocol.ascii.OperationFactoryTest -[INFO] Running net.spy.memcached.protocol.ascii.OperationExceptionTest -[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.protocol.ascii.OperationExceptionTest -[INFO] Running net.spy.memcached.protocol.ascii.AsciiToStringTest -[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.009 s - in net.spy.memcached.protocol.ascii.AsciiToStringTest -[INFO] Running net.spy.memcached.ConsistentHashingTest -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.031 s - in net.spy.memcached.ConsistentHashingTest -[INFO] Running net.spy.memcached.KetamaNodeLocatorTest -[INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.244 s - in net.spy.memcached.KetamaNodeLocatorTest -[INFO] Running net.spy.memcached.MemcachedClientConstructorTest -2023-04-19 13:13:59.073 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.074 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:59.075 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:59.077 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.078 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:59.083 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:59.084 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.085 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -[INFO] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.009 s - in net.spy.memcached.MemcachedClientConstructorTest -[INFO] Running net.spy.memcached.ConnectionFactoryTest -[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.ConnectionFactoryTest -[INFO] Running net.spy.memcached.internal.ListenableFutureTest -2023-04-19 13:13:59.093 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.536 s - in net.spy.memcached.internal.ListenableFutureTest -[INFO] Running net.spy.memcached.internal.SingleElementInfiniteIteratorTest -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.internal.SingleElementInfiniteIteratorTest -[INFO] Running net.spy.memcached.internal.CheckedOperationTimeoutExceptionTest -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.internal.CheckedOperationTimeoutExceptionTest -[INFO] Running net.spy.memcached.TimeoutTest -2023-04-19 13:13:59.642 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.643 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:59.656 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: incr Key: k Amount: 1, toWrite=0, interested=0} +2024-05-22 21:38:19.265 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.275 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.275 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.276 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.276 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2335,11 +2241,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:59.656 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: incr Key: k Amount: 1, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:59.683 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:59.684 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.684 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:59.700 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: incr Key: k Amount: 1, toWrite=0, interested=0} +2024-05-22 21:38:19.277 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.288 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.289 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.289 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.290 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2347,11 +2253,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:59.700 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: incr Key: k Amount: 1, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:59.723 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:59.731 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.732 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:59.748 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: get Keys: kExp: 0, toWrite=0, interested=0} +2024-05-22 21:38:19.290 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.300 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.301 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.301 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.301 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2359,11 +2265,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:59.748 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: get Keys: kExp: 0, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:59.783 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:59.784 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.784 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:59.792 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} +2024-05-22 21:38:19.302 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.312 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.312 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.312 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.313 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2371,11 +2277,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:59.792 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:59.823 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:59.824 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.824 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:59.828 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: cas Key: k Cas Value: 1 Flags: 0 Exp: 0 Data Length: 4, toWrite=0, interested=0} +2024-05-22 21:38:19.313 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.323 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.324 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.324 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.324 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2383,11 +2289,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:59.829 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: cas Key: k Cas Value: 1 Flags: 0 Exp: 0 Data Length: 4, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:13:59.856 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.857 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:59.857 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:59.858 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} +2024-05-22 21:38:19.325 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.335 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.335 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.335 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.336 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2395,121 +2301,116 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:13:59.858 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.229 s - in net.spy.memcached.TimeoutTest +2024-05-22 21:38:19.336 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.347 INFO [INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.163 s - in net.spy.memcached.BinaryCancellationTest +net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Running net.spy.memcached.MemcachedClientConstructorTest +2024-05-22 21:38:19.350 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.351 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.352 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.353 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.354 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.356 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.358 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.358 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.365 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 s - in net.spy.memcached.MemcachedClientConstructorTest +[INFO] Running net.spy.memcached.KetamaNodeKeyFormatterTest +[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 s - in net.spy.memcached.KetamaNodeKeyFormatterTest +[INFO] Running net.spy.memcached.KetamaConnectionFactoryTest +[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.KetamaConnectionFactoryTest [INFO] Running net.spy.memcached.CASMutatorTest -2023-04-19 13:13:59.891 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.891 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:59.892 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:59.894 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.894 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:13:59.894 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:59.919 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:13:59.920 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:13:59.920 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.047 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.049 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.050 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.076 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.076 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.077 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.078 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.079 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.084 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.085 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.087 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.088 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.089 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.090 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.092 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.094 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.095 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.098 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.100 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.101 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.102 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.103 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.104 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.105 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.109 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.116 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.117 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.118 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.119 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.120 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.121 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.122 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.122 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.128 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.129 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.130 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.131 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.132 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.133 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.138 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.139 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.140 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.141 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.142 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.143 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.148 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.149 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.149 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.150 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.151 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.153 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.154 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.168 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.169 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.170 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.171 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2023-04-19 13:14:00.176 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.176 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.177 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.203 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.204 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.204 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.255 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.256 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.256 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.282 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.282 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.283 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.300 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.301 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.301 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.320 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.320 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.327 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.328 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.329 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.331 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.452 s - in net.spy.memcached.CASMutatorTest -[INFO] Running net.spy.memcached.MemcachedNodeROImplTest -2023-04-19 13:14:00.351 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 s - in net.spy.memcached.MemcachedNodeROImplTest -[INFO] Running net.spy.memcached.BinaryCancellationTest -2023-04-19 13:14:00.355 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.362 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.366 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.366 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.371 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.374 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: -1 Opaque: -1 Keys: k2 k, toWrite=0, interested=0} -java.net.ConnectException: Connection refused - at java.base/sun.nio.ch.Net.pollConnect(Native Method) - at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) - at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) - at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) - at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.374 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: -1 Opaque: -1 Keys: k2 k, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.403 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.404 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.404 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.416 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.417 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.419 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.432 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 0 Opaque: 10000072 Key: k, toWrite=0, interested=0} +2024-05-22 21:38:19.376 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.376 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.377 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.377 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.378 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.379 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.379 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.380 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.410 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.411 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.411 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.412 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.412 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.412 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.413 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.414 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.414 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.415 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.415 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.416 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.416 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.417 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.417 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.418 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.418 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.419 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.419 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.420 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.420 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.421 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.422 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.422 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.423 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.423 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.424 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.424 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.425 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.425 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.426 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.426 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.427 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.427 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.428 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.428 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.429 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.429 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.430 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.430 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.431 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.431 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.432 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.432 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.433 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.433 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.434 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.434 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.435 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.435 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.436 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.436 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.437 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.437 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.438 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.438 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-05-22 21:38:19.439 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.439 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.439 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.440 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.441 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.441 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.442 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.442 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.443 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.444 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.444 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.444 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.446 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.446 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.447 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.447 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.448 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.448 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.449 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.449 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.449 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.450 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.075 s - in net.spy.memcached.CASMutatorTest +[INFO] Running net.spy.memcached.MemcachedConnectionTest +2024-05-22 21:38:19.452 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.453 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.453 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2517,11 +2418,72 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.432 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 0 Opaque: 10000072 Key: k, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.447 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.452 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.452 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.454 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} +2024-05-22 21:38:19.453 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:19.455 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.455 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 s - in net.spy.memcached.MemcachedConnectionTest +[INFO] Running net.spy.memcached.ArrayModNodeLocatorTest +[INFO] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 s - in net.spy.memcached.ArrayModNodeLocatorTest +[INFO] Running net.spy.memcached.DefaultHashAlgorithmTest +[INFO] Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.DefaultHashAlgorithmTest +[INFO] Running net.spy.memcached.tapmessage.ResponseMessageFixedOrderTest +[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 s - in net.spy.memcached.tapmessage.ResponseMessageFixedOrderTest +[INFO] Running net.spy.memcached.tapmessage.ResponseMessageWrongOrderTest +[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.tapmessage.ResponseMessageWrongOrderTest +[INFO] Running net.spy.memcached.tapmessage.TapDeleteTest +[INFO] Tests run: 14, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.tapmessage.TapDeleteTest +[INFO] Running net.spy.memcached.MetricsTest +2024-05-22 21:38:19.485 INFO net.spy.memcached.ConnectionFactoryBuilder$1: Metric collection enabled (Profile PERFORMANCE). +SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder". +SLF4J: Defaulting to no-operation (NOP) logger implementation +SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details. +2024-05-22 21:38:19.494 INFO net.spy.memcached.ConnectionFactoryBuilder$1: Metric collection enabled (Profile PERFORMANCE). +2024-05-22 21:38:19.495 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.495 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.496 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for metrics:test. +2024-05-22 21:38:19.497[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 s - in net.spy.memcached.MetricsTest + INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Running net.spy.memcached.ToStringTest +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.ToStringTest +[INFO] Running net.spy.memcached.ConsistentHashingTest +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 s - in net.spy.memcached.ConsistentHashingTest +[INFO] Running net.spy.memcached.KetamaNodeLocatorTest +[INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.074 s - in net.spy.memcached.KetamaNodeLocatorTest +[INFO] Running net.spy.memcached.ErrorCodeTest +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.ErrorCodeTest +[INFO] Running net.spy.memcached.CancelFailureModeTest +2024-05-22 21:38:19.583 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.584 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.584 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:11311, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.585 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to exception on {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} +java.nio.channels.CancelledKeyException + at java.base/sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:75) + at java.base/sun.nio.ch.SelectionKeyImpl.readyOps(SelectionKeyImpl.java:138) + at java.base/java.nio.channels.SelectionKey.isReadable(SelectionKey.java:355) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:686) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:19.585 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.585 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:19.585 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:19.686 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.103 s - in net.spy.memcached.CancelFailureModeTest +[INFO] Running net.spy.memcached.TimeoutNowriteTest +2024-05-22 21:38:19.688 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:19.688 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +Operation attempted: +net.spy.memcached.TimeoutNowriteTest$3@1e3c1c7 +Trying to get: +Received a line. +Complete. + +Op timed out is true +2024-05-22 21:38:20.789 INFO net.spy.memcached.MemcachedConnection[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.102 s - in net.spy.memcached.TimeoutNowriteTest +: Shut down memcached client +[INFO] Running net.spy.memcached.TimeoutTest +2024-05-22 21:38:20.791 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:20.792 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:20.792 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2529,11 +2491,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.454 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.471 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.472 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.473 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.484 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 8 Opaque: 10000074 Delay: 0, toWrite=0, interested=0} +2024-05-22 21:38:20.793 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:20.813 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:20.813 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:20.814 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:20.814 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2541,11 +2503,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.484 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 8 Opaque: 10000074 Delay: 0, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.500 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.500 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.501 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.501 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 8 Opaque: 10000075 Delay: 0, toWrite=0, interested=0} +2024-05-22 21:38:20.815 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:20.835 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:20.835 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:20.835 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:20.836 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2553,11 +2515,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.502 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 8 Opaque: 10000075 Delay: 0, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.516 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.517 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.517 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.518 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 1 Opaque: 10000076 Key: x Cas: 3 Exp: 0 Flags: 0 Data Length: 1, toWrite=0, interested=0} +2024-05-22 21:38:20.836 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:20.856 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:20.857 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:20.857 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:20.858 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2565,11 +2527,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.518 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 1 Opaque: 10000076 Key: x Cas: 3 Exp: 0 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.536 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.536 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.537 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.538 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 2 Opaque: 10000077 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0} +2024-05-22 21:38:20.858 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:20.878 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:20.878 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:20.879 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:20.879 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2577,11 +2539,11 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.538 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 2 Opaque: 10000077 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.552 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.552 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.553 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.553 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 1 Opaque: 10000078 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0} +2024-05-22 21:38:20.879 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:20.899 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:20.900 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:20.900 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:20.901 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2589,11 +2551,15 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.554 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 1 Opaque: 10000078 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.568 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.568 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.570 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.571 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: -1 Opaque: -1 Keys: k2 k, toWrite=0, interested=0} +2024-05-22 21:38:20.901 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:20.921 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.131 s - in net.spy.memcached.TimeoutTest +[INFO] Running net.spy.memcached.spring.MemcachedClientFactoryBeanTest +2024-05-22 21:38:20.924 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:20.925 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:22211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:20.925 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:22212, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 s - in net.spy.memcached.spring.MemcachedClientFactoryBeanTest +2024-05-22 21:38:20.926 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:22212, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2601,10 +2567,9 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.571 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: -1 Opaque: -1 Keys: k2 k, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.588 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.588 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.590 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 3 Opaque: 10000082 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0} +[INFO] Running net.spy.memcached.internal.SingleElementInfiniteIteratorTest +2024-05-22 21:38:20.926 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:22212, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:20.926 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:22211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2612,12 +2577,32 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.590 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 3 Opaque: 10000082 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.593 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.604 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.604 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.611 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.616 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 0 Opaque: 10000083 Key: k, toWrite=0, interested=0} +2024-05-22 21:38:20.926 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:22211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.internal.SingleElementInfiniteIteratorTest +[INFO] Running net.spy.memcached.internal.ListenableFutureTest +[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.5 s - in net.spy.memcached.internal.ListenableFutureTest +[INFO] Running net.spy.memcached.internal.CheckedOperationTimeoutExceptionTest +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.internal.CheckedOperationTimeoutExceptionTest +[INFO] Running net.spy.memcached.ConnectionFactoryBuilderTest +[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 s - in net.spy.memcached.ConnectionFactoryBuilderTest +[INFO] Running net.spy.memcached.LongClientTest +2024-05-22 21:38:21.441 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:21.442 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:21.442 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:21.442 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:21.443 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:21.667 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:21.667 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:21.667 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:21.668 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.225 s - in net.spy.memcached.LongClientTest +[INFO] Running net.spy.memcached.protocol.ascii.BaseOpTest +[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.protocol.ascii.BaseOpTest +[INFO] Running net.spy.memcached.protocol.ascii.OperationExceptionTest +[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.protocol.ascii.OperationExceptionTest +[INFO] Running net.spy.memcached.protocol.ascii.OperationFactoryTest +2024-05-22 21:38:23.474 INFO net.spy.memcached.MemcachedConnection: Reconnecting {QA sa=/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} +2024-05-22 21:38:23.475 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2625,17 +2610,18 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.616 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: 0 Opaque: 10000083 Key: k, toWrite=0, interested=0}, attempt 1. -[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.271 s - in net.spy.memcached.BinaryCancellationTest -[INFO] Running net.spy.memcached.spring.MemcachedClientFactoryBeanTest -2023-04-19 13:14:00.643 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:00.647 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.648 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:22211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.648 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:22212, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 s - in net.spy.memcached.spring.MemcachedClientFactoryBeanTest -[INFO] Running net.spy.memcached.MetricsTest -2023-04-19 13:14:00.661 INFO net.spy.memcached.ConnectionFactoryBuilder$1: Metric collection enabled (Profile PERFORMANCE). -2023-04-19 13:14:00.664 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:22211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} +2024-05-22 21:38:23.475 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 2. +[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.885 s - in net.spy.memcached.protocol.ascii.OperationFactoryTest +[INFO] Running net.spy.memcached.protocol.ascii.AsciiToStringTest +[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.protocol.ascii.AsciiToStringTest +[INFO] Running net.spy.memcached.protocol.binary.BinaryToStringTest +[INFO] Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 s - in net.spy.memcached.protocol.binary.BinaryToStringTest +[INFO] Running net.spy.memcached.protocol.binary.OperatonTest +[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.protocol.binary.OperatonTest +[INFO] Running net.spy.memcached.protocol.binary.OperationFactoryTest +2024-05-22 21:38:24.947 INFO net.spy.memcached.MemcachedConnection: Reconnecting {QA sa=/127.0.0.1:22212, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} +2024-05-22 21:38:24.947 INFO net.spy.memcached.MemcachedConnection: Reconnecting {QA sa=/127.0.0.1:22211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} +2024-05-22 21:38:24.947 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:22211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2643,8 +2629,8 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.667 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:22211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -2023-04-19 13:14:00.668 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:22212, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} +2024-05-22 21:38:24.947 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:22211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 2. +2024-05-22 21:38:24.948 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:22212, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2652,55 +2638,17 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:00.668 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:22212, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder". -SLF4J: Defaulting to no-operation (NOP) logger implementation -SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details. -2023-04-19 13:14:00.702 INFO net.spy.memcached.ConnectionFactoryBuilder$1: Metric collection enabled (Profile PERFORMANCE). -2023-04-19 13:14:00.704 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.704 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.706 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for metrics:test. -[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.049 s - in net.spy.memcached.MetricsTest -[INFO] Running net.spy.memcached.CacheMapTest -2023-04-19 13:14:00.726 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.045 s - in net.spy.memcached.CacheMapTest -[INFO] Running net.spy.memcached.CancelFailureModeTest -2023-04-19 13:14:00.767 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.774 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.774 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:11311, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.788 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.789 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.791 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.134 s - in net.spy.memcached.CancelFailureModeTest -[INFO] Running net.spy.memcached.TimeoutNowriteTest -2023-04-19 13:14:00.906 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:00.906 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:00.911 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -Operation attempted: -net.spy.memcached.TimeoutNowriteTest$3@11b9a3 -Trying to get: -Received a line. -Complete. - -Op timed out is true -2023-04-19 13:14:02.027 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.122 s - in net.spy.memcached.TimeoutNowriteTest -[INFO] Running net.spy.memcached.ErrorCodeTest -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.ErrorCodeTest -[INFO] Running net.spy.memcached.compat.log.LoggingTest -2023-04-19 13:14:02.042 WARN net.spy.memcached.compat.log.LoggingTest: warn message -2023-04-19 13:14:02.042 WARN net.spy.memcached.compat.log.LoggingTest: test message -2023-04-19 13:14:02.042 ERROR net.spy.memcached.compat.log.LoggingTest: error message -2023-04-19 13:14:02.043 ERROR net.spy.memcached.compat.log.LoggingTest: test message -2023-04-19 13:14:02.043 FATAL net.spy.memcached.compat.log.LoggingTest: fatal message -2023-04-19 13:14:02.043 FATAL net.spy.memcached.compat.log.LoggingTest: test message -2023-04-19 13:14:02.044 INFO net.spy.memcached.compat.log.LoggingTest: info message -2023-04-19 13:14:02.044 WARN net.spy.memcached.compat.log.LoggingTest: warn message -2023-04-19 13:14:02.044 ERROR net.spy.memcached.compat.log.LoggingTest: error message -2023-04-19 13:14:02.044 FATAL net.spy.memcached.compat.log.LoggingTest: fatal message -2023-04-19 13:14:02.044 FATAL net.spy.memcached.compat.log.LoggingTest: fatal message with exception -java.lang.Exception - at net.spy.memcached.compat.log.LoggingTest.testMyLogger(LoggingTest.java:119) +2024-05-22 21:38:24.948 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:22212, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 2. +[INFO] Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.294 s - in net.spy.memcached.protocol.binary.OperationFactoryTest +[INFO] Running net.spy.memcached.MemcachedNodeROImplTest +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.MemcachedNodeROImplTest +[INFO] Running net.spy.memcached.AddrUtilTest +java.lang.NumberFormatException: For input string: "more" + at java.base/java.lang.NumberFormatException.forInputString(NumberFormatException.java:67) + at java.base/java.lang.Integer.parseInt(Integer.java:668) + at java.base/java.lang.Integer.parseInt(Integer.java:786) + at net.spy.memcached.AddrUtil.getAddresses(AddrUtil.java:70) + at net.spy.memcached.AddrUtilTest.testBrokenHost(AddrUtilTest.java:67) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) @@ -2722,19 +2670,21 @@ at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) -2023-04-19 13:14:02.046 INFO net.spy.memcached.compat.log.LoggingTest: info message -Apr 19, 2023 1:14:02 PM net.spy.memcached.compat.log.LoggingTest testSunLogger -INFO: info message -Apr 19, 2023 1:14:02 PM net.spy.memcached.compat.log.LoggingTest testSunLogger -WARNING: warn message -Apr 19, 2023 1:14:02 PM net.spy.memcached.compat.log.LoggingTest testSunLogger -SEVERE: error message -Apr 19, 2023 1:14:02 PM net.spy.memcached.compat.log.LoggingTest testSunLogger -SEVERE: fatal message -Apr 19, 2023 1:14:02 PM net.spy.memcached.compat.log.LoggingTest testSunLogger -SEVERE: fatal message with exception +[INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.AddrUtilTest +[INFO] Running net.spy.memcached.compat.log.LoggingTest +2024-05-22 21:38:27.880 WARN net.spy.memcached.compat.log.LoggingTest: warn message +2024-05-22 21:38:27.880 WARN net.spy.memcached.compat.log.LoggingTest: test message +2024-05-22 21:38:27.880 ERROR net.spy.memcached.compat.log.LoggingTest: error message +2024-05-22 21:38:27.881 ERROR net.spy.memcached.compat.log.LoggingTest: test message +2024-05-22 21:38:27.881 FATAL net.spy.memcached.compat.log.LoggingTest: fatal message +2024-05-22 21:38:27.881 FATAL net.spy.memcached.compat.log.LoggingTest: test message +2024-05-22 21:38:27.881 INFO net.spy.memcached.compat.log.LoggingTest: info message +2024-05-22 21:38:27.881 WARN net.spy.memcached.compat.log.LoggingTest: warn message +2024-05-22 21:38:27.881 ERROR net.spy.memcached.compat.log.LoggingTest: error message +2024-05-22 21:38:27.882 FATAL net.spy.memcached.compat.log.LoggingTest: fatal message +2024-05-22 21:38:27.882 FATAL net.spy.memcached.compat.log.LoggingTest: fatal message with exception java.lang.Exception - at net.spy.memcached.compat.log.LoggingTest.testSunLogger(LoggingTest.java:101) + at net.spy.memcached.compat.log.LoggingTest.testMyLogger(LoggingTest.java:119) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) @@ -2756,13 +2706,19 @@ at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) - -Apr 19, 2023 1:14:02 PM net.spy.memcached.compat.log.SunLogger log -SEVERE: test null -Apr 19, 2023 1:14:02 PM net.spy.memcached.compat.log.SunLogger log -SEVERE: null message with exception and no requestor +2024-05-22 21:38:27.883 INFO net.spy.memcached.compat.log.LoggingTest: info message +May 22, 2024 9:38:27 PM net.spy.memcached.compat.log.LoggingTest testSunLogger +INFO: info message +May 22, 2024 9:38:27 PM net.spy.memcached.compat.log.LoggingTest testSunLogger +WARNING: warn message +May 22, 2024 9:38:27 PM net.spy.memcached.compat.log.LoggingTest testSunLogger +SEVERE: error message +May 22, 2024 9:38:27 PM net.spy.memcached.compat.log.LoggingTest testSunLogger +SEVERE: fatal message +May 22, 2024 9:38:27 PM net.spy.memcached.compat.log.LoggingTest testSunLogger +SEVERE: fatal message with exception java.lang.Exception - at net.spy.memcached.compat.log.LoggingTest.testSunLogger(LoggingTest.java:103) + at net.spy.memcached.compat.log.LoggingTest.testSunLogger(LoggingTest.java:101) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) @@ -2785,16 +2741,12 @@ at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) -[INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.096 s - in net.spy.memcached.compat.log.LoggingTest -[INFO] Running net.spy.memcached.DefaultHashAlgorithmTest -[INFO] Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 s - in net.spy.memcached.DefaultHashAlgorithmTest -[INFO] Running net.spy.memcached.AddrUtilTest -java.lang.NumberFormatException: For input string: "more" - at java.base/java.lang.NumberFormatException.forInputString(NumberFormatException.java:67) - at java.base/java.lang.Integer.parseInt(Integer.java:668) - at java.base/java.lang.Integer.parseInt(Integer.java:786) - at net.spy.memcached.AddrUtil.getAddresses(AddrUtil.java:70) - at net.spy.memcached.AddrUtilTest.testBrokenHost(AddrUtilTest.java:67) +May 22, 2024 9:38:27 PM net.spy.memcached.compat.log.SunLogger log +SEVERE: test null +May 22, 2024 9:38:27 PM net.spy.memcached.compat.log.SunLogger log +SEVERE: null message with exception and no requestor +java.lang.Exception + at net.spy.memcached.compat.log.LoggingTest.testSunLogger(LoggingTest.java:103) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) @@ -2816,15 +2768,12 @@ at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345) at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) -[INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.AddrUtilTest -[INFO] Running net.spy.memcached.ConnectionFactoryBuilderTest -[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.ConnectionFactoryBuilderTest -[INFO] Running net.spy.memcached.MemcachedConnectionTest -2023-04-19 13:14:02.189 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.190 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.201 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.201 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.203 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} + +[INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 s - in net.spy.memcached.compat.log.LoggingTest +[INFO] Running net.spy.memcached.AsciiCancellationTest +2024-05-22 21:38:27.909 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:27.909 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:27.910 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} java.net.ConnectException: Connection refused at java.base/sun.nio.ch.Net.pollConnect(Native Method) at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) @@ -2832,43 +2781,195 @@ at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) -2023-04-19 13:14:02.204 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. -[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.031 s - in net.spy.memcached.MemcachedConnectionTest -[INFO] Running net.spy.memcached.QueueOverflowTest -2023-04-19 13:14:02.217 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.218 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.225 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.226 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.227 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:02.263 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:02.268 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.268 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.280 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.280 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.283 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:02.319 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.095 s - in net.spy.memcached.QueueOverflowTest -[INFO] Running net.spy.memcached.util.StringUtilsTest -[INFO] Tests run: 16, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.006 s - in net.spy.memcached.util.StringUtilsTest -[INFO] Running net.spy.memcached.util.CacheLoaderTest -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.298 s - in net.spy.memcached.util.CacheLoaderTest +2024-05-22 21:38:27.910 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:27.910 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:27.910 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:27.911 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:27.911 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:27.921 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:27.921 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:27.922 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:27.922 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:27.922 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:27.923 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:27.923 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: gets Keys: kExp: 0, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:27.923 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: gets Keys: kExp: 0, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:27.933 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:27.934 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:27.934 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:27.934 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:27.934 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:27.944 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:27.945 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:27.945 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:27.945 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:27.946 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:27.956 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:27.956 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:27.956 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:27.957 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:27.957 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:27.967 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:27.967 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:27.967 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:27.968 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:27.968 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:27.978 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:27.978 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:27.978 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:27.979 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: add Key: x Flags: 0 Exp: 3 Data Length: 1, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:27.979 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: add Key: x Flags: 0 Exp: 3 Data Length: 1, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:27.989 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:27.989 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:27.989 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:27.990 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:27.990 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:28.000 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.000 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.001 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.001 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:28.001 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:28.011 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.011 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.012 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.012 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:28.012 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=1, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:28.022 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.022 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.022 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.023 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: get Keys: kExp: 0, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:28.023 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:64213, #Rops=0, #Wops=1, #iq=0, topRop=null, topWop=Cmd: get Keys: kExp: 0, toWrite=0, interested=0}, attempt 1. +2024-05-22 21:38:28.033 INFO net.spy.memcached.MemcachedConnection[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.123 s - in net.spy.memcached.AsciiCancellationTest +: Shut down memcached client +[INFO] Running net.spy.memcached.ConnectionFactoryTest +[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.ConnectionFactoryTest [INFO] Running net.spy.memcached.ObserverTest -2023-04-19 13:14:02.641 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.642 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.656 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.657 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.659 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:02.699 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:02.700 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.700 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.727 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:02.728 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.728 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.735 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2023-04-19 13:14:02.736 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2023-04-19 13:14:02.736 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue -2023-04-19 13:14:02.747 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.107 s - in net.spy.memcached.ObserverTest - +2024-05-22 21:38:28.035 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.035 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.035 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.035 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.036 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.036 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.037 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.037 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.038 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.038 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.038 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.038 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.039 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.039 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.039 INFO net.spy.memcached.MemcachedConnection[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 s - in net.spy.memcached.ObserverTest +: Shut down memcached client +[INFO] Running net.spy.memcached.RedistributeFailureModeTest +2024-05-22 21:38:28.040 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.040 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.041 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:11311, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.041 INFO net.spy.memcached.MemcachedConnection: Reconnecting due to failure to connect to {QA sa=/127.0.0.1:11311, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} +java.net.ConnectException: Connection refused + at java.base/sun.nio.ch.Net.pollConnect(Native Method) + at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) + at java.base/sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:946) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:691) + at net.spy.memcached.MemcachedConnection.handleIO(MemcachedConnection.java:450) + at net.spy.memcached.MemcachedConnection.run(MemcachedConnection.java:1457) +2024-05-22 21:38:28.041 WARN net.spy.memcached.MemcachedConnection: Closing, and reopening {QA sa=/127.0.0.1:11311, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0}, attempt 1. +testMixedSetsAndUpdates complete. +2024-05-22 21:38:28.145 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.145 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.146 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.247 INFO net.spy.memcached.MemcachedConnection[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.206 s - in net.spy.memcached.RedistributeFailureModeTest +: Shut down memcached client +[INFO] Running net.spy.memcached.QueueOverflowTest +2024-05-22 21:38:28.248 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.248 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.248 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.248 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.249 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.249 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.250 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.250 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.250 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-05-22 21:38:28.250 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-05-22 21:38:28.250 INFO net.spy.memcached.MemcachedConnection: Added {QA sa=/127.0.0.1:20000, #Rops=0, #Wops=0, #iq=0, topRop=null, topWop=null, toWrite=0, interested=0} to connect queue +2024-05-22 21:38:28.251 INFO net.spy.memcached.MemcachedConnection[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 s - in net.spy.memcached.QueueOverflowTest +: Shut down memcached client [INFO] [INFO] Results: [INFO] @@ -2877,8 +2978,8 @@ [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ -[INFO] Total time: 42.222 s -[INFO] Finished at: 2023-04-19T13:14:04-12:00 +[INFO] Total time: 20.647 s +[INFO] Finished at: 2024-05-22T21:38:38+14:00 [INFO] ------------------------------------------------------------------------ [ ! -s /build/spymemcached-2.12.3+dfsg/debian/build/memcached.pid ] || /bin/kill `cat /build/spymemcached-2.12.3+dfsg/debian/build/memcached.pid` make[1]: Leaving directory '/build/spymemcached-2.12.3+dfsg' @@ -2904,8 +3005,8 @@ [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ -[INFO] Total time: 1.307 s -[INFO] Finished at: 2023-04-19T13:14:08-12:00 +[INFO] Total time: 0.355 s +[INFO] Finished at: 2024-05-22T21:38:39+14:00 [INFO] ------------------------------------------------------------------------  mh_resolve_dependencies --non-interactive --offline --build -plibspymemcached-java --base-directory=/build/spymemcached-2.12.3\+dfsg --non-explore Analysing pom.xml... @@ -2932,12 +3033,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/50499/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/50499/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/18661 and its subdirectories -I: Current time: Wed Apr 19 13:14:18 -12 2023 -I: pbuilder-time-stamp: 1681953258 +I: removing directory /srv/workspace/pbuilder/50499 and its subdirectories +I: Current time: Wed May 22 21:38:43 +14 2024 +I: pbuilder-time-stamp: 1716363523