Diff of the two buildlogs: -- --- b1/build.log 2024-04-29 07:15:05.020146704 +0000 +++ b2/build.log 2024-04-29 07:28:27.921903605 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Sun Apr 28 19:07:11 -12 2024 -I: pbuilder-time-stamp: 1714374431 +I: Current time: Mon Apr 29 21:15:16 +14 2024 +I: pbuilder-time-stamp: 1714374916 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/unstable-reproducible-base.tgz] I: copying local configuration @@ -27,52 +27,84 @@ dpkg-source: info: applying 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/23005/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/3309/tmp/hooks/D01_modify_environment starting +debug: Running on ff4a. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Apr 29 07:16 /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/3309/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/3309/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='armhf' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=3 ' - DISTRIBUTION='unstable' - HOME='/root' - HOST_ARCH='armhf' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="21" [3]="1" [4]="release" [5]="arm-unknown-linux-gnueabihf") + BASH_VERSION='5.2.21(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=armhf + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=4 ' + DIRSTACK=() + DISTRIBUTION=unstable + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=arm + HOST_ARCH=armhf IFS=' ' - INVOCATION_ID='b1a0f0402af0460d96637ff78d8f7d1d' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='23005' - PS1='# ' - PS2='> ' + INVOCATION_ID=15ec6bb6524b43daad2e09b300b60140 + LANG=C + LANGUAGE=it_CH:it + LC_ALL=C + MACHTYPE=arm-unknown-linux-gnueabihf + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnueabihf + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=3309 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.38V7xjRX/pbuilderrc_iYfr --distribution unstable --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.38V7xjRX/b1 --logfile b1/build.log spymemcached_2.12.3+dfsg-3.dsc' - SUDO_GID='110' - SUDO_UID='103' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://10.0.0.15:3142/' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.38V7xjRX/pbuilderrc_QneN --distribution unstable --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.38V7xjRX/b2 --logfile b2/build.log spymemcached_2.12.3+dfsg-3.dsc' + SUDO_GID=113 + SUDO_UID=107 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://10.0.0.15:3142/ I: uname -a - Linux virt64z 6.1.0-20-arm64 #1 SMP Debian 6.1.85-1 (2024-04-11) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-20-armmp-lpae #1 SMP Debian 6.1.85-1 (2024-04-11) armv7l GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Apr 25 07:43 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/23005/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Apr 28 07:45 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/3309/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -408,7 +440,7 @@ Get: 278 http://deb.debian.org/debian unstable/main armhf maven-repo-helper all 1.11 [142 kB] Get: 279 http://deb.debian.org/debian unstable/main armhf maven-debian-helper all 2.6.4 [108 kB] Get: 280 http://deb.debian.org/debian unstable/main armhf net-tools armhf 2.10-1.1 [229 kB] -Fetched 242 MB in 7s (32.4 MB/s) +Fetched 242 MB in 30s (8138 kB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package libevent-2.1-7t64:armhf. (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 ... 19440 files and directories currently installed.) @@ -1739,7 +1771,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/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/3309/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for unstable +I: user script /srv/workspace/pbuilder/3309/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/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 @@ -1810,13 +1846,13 @@ [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ -[INFO] Total time: 32.587 s -[INFO] Finished at: 2024-04-29T07:13:35Z +[INFO] Total time: 01:16 min +[INFO] Finished at: 2024-04-29T07:24:55Z [INFO] ------------------------------------------------------------------------ debian/rules override_dh_auto_test make[1]: Entering directory '/build/reproducible-path/spymemcached-2.12.3+dfsg' mkdir -p /build/reproducible-path/spymemcached-2.12.3+dfsg/debian/build -memcached -u pbuilder1 -p 20000 -P /build/reproducible-path/spymemcached-2.12.3+dfsg/debian/build/memcached.pid -d +memcached -u pbuilder2 -p 20000 -P /build/reproducible-path/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/reproducible-path/spymemcached-2.12.3\+dfsg -Dclassworlds.conf=/etc/maven/m2-debian.conf -Dproperties.file.manual=/build/reproducible-path/spymemcached-2.12.3\+dfsg/debian/maven.properties org.codehaus.plexus.classworlds.launcher.Launcher -s/etc/maven/settings-debian.xml -Ddebian.dir=/build/reproducible-path/spymemcached-2.12.3\+dfsg/debian -Dmaven.repo.local=/build/reproducible-path/spymemcached-2.12.3\+dfsg/debian/maven-repo --batch-mode -Dserver.port_number=20000 -Dtest.type=ci test @@ -1847,11 +1883,12 @@ [INFO] ------------------------------------------------------- [INFO] T E S T S [INFO] ------------------------------------------------------- -[INFO] Running net.spy.memcached.CancelFailureModeTest -2024-04-29 07:13:48.398 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:48.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-04-29 07:13:48.453 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-04-29 07:13:48.473 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} +[INFO] Running net.spy.memcached.ErrorCodeTest +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.994 s - in net.spy.memcached.ErrorCodeTest +[INFO] Running net.spy.memcached.AsciiCancellationTest +2024-04-29 07:25:30.190 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:30.412 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-04-29 07:25:30.458 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) @@ -1859,36 +1896,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) -2024-04-29 07:13:48.480 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. -2024-04-29 07:13:48.523 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:48.524 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-04-29 07:13:48.534 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.676 s - in net.spy.memcached.CancelFailureModeTest -[INFO] Running net.spy.memcached.internal.ListenableFutureTest -2024-04-29 07:13:48.687 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.605 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.002 s - in net.spy.memcached.internal.CheckedOperationTimeoutExceptionTest -[INFO] Running net.spy.memcached.internal.SingleElementInfiniteIteratorTest -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.025 s - in net.spy.memcached.internal.SingleElementInfiniteIteratorTest -[INFO] Running net.spy.memcached.QueueOverflowTest -2024-04-29 07:13:49.544 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.545 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-04-29 07:13:49.557 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.558 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-04-29 07:13:49.566 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.590 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.592 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.593 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-04-29 07:13:49.600 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.601 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-04-29 07:13:49.602 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.118 s - in net.spy.memcached.QueueOverflowTest -[INFO] Running net.spy.memcached.BinaryCancellationTest -2024-04-29 07:13:49.638 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.695 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.697 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-04-29 07:13:49.725 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: 1 Key: x, toWrite=0, interested=0} +2024-04-29 07:25:30.479 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-04-29 07:25:30.507 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:30.511 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:30.519 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-04-29 07:25:30.535 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) @@ -1896,11 +1908,14 @@ 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-04-29 07:13:49.727 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: 1 Key: x, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:13:49.740 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.742 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-04-29 07:13:49.748 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.763 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-04-29 07:25:30.546 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-04-29 07:25:30.570 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:30.581 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-04-29 07:25:30.587 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:30.598 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:30.607 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:30.610 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-04-29 07:25:30.627 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) @@ -1908,14 +1923,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) -2024-04-29 07:13:49.764 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-04-29 07:13:49.787 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.789 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.790 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-04-29 07:13:49.803 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.804 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-04-29 07:13:49.807 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.817 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: 6 Key: k, toWrite=0, interested=0} +2024-04-29 07:25:30.636 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-04-29 07:25:30.654 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:30.664 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-04-29 07:25:30.666 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:30.679 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) @@ -1923,11 +1935,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) -2024-04-29 07:13:49.819 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: 6 Key: k, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:13:49.832 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.835 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.837 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-04-29 07:13:49.851 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: 4 Opaque: 7 Key: x Cas: 0, toWrite=0, interested=0} +2024-04-29 07:25:30.687 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-04-29 07:25:30.705 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:30.716 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-04-29 07:25:30.718 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:30.727 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) @@ -1935,11 +1947,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) -2024-04-29 07:13:49.854 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: 4 Opaque: 7 Key: x Cas: 0, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:13:49.869 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.870 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.872 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-04-29 07:13:49.879 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: 8 Delay: 0, toWrite=0, interested=0} +2024-04-29 07:25:30.730 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-04-29 07:25:30.758 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:30.764 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-04-29 07:25:30.767 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:30.780 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} 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) @@ -1947,11 +1959,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) -2024-04-29 07:13:49.880 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: 8 Delay: 0, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:13:49.899 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.902 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.903 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-04-29 07:13:49.918 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: 9 Delay: 0, toWrite=0, interested=0} +2024-04-29 07:25:30.788 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. +2024-04-29 07:25:30.800 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:30.803 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:30.811 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-04-29 07:25:30.825 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) @@ -1959,11 +1971,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) -2024-04-29 07:13:49.919 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: 9 Delay: 0, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:13:49.926 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.928 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.929 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-04-29 07:13:49.943 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: 10 Key: x Cas: 3 Exp: 0 Flags: 0 Data Length: 1, toWrite=0, interested=0} +2024-04-29 07:25:30.843 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-04-29 07:25:30.868 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:30.891 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:30.893 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-04-29 07:25:30.919 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) @@ -1971,11 +1983,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) -2024-04-29 07:13:49.944 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: 10 Key: x Cas: 3 Exp: 0 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:13:49.960 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.962 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.963 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-04-29 07:13:49.975 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: 11 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0} +2024-04-29 07:25:30.932 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-04-29 07:25:30.949 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:30.959 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:30.962 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-04-29 07:25:30.978 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) @@ -1983,11 +1995,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) -2024-04-29 07:13:49.976 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: 11 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:13:49.987 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:49.992 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:49.993 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-04-29 07:13:50.004 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: 12 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0} +2024-04-29 07:25:30.983 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-04-29 07:25:30.985 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:30.998 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:31.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-04-29 07:25:31.020 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) @@ -1995,11 +2007,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) -2024-04-29 07:13:50.005 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: 12 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:13:50.018 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:50.025 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:50.026 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-04-29 07:13:50.043 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-04-29 07:25:31.033 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:31.042 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:31.045 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-04-29 07:25:31.073 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) @@ -2007,11 +2018,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) -2024-04-29 07:13:50.045 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. -2024-04-29 07:13:50.058 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:50.060 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:50.062 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-04-29 07:13:50.071 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: 16 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0} +2024-04-29 07:25:31.086 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-04-29 07:25:31.093 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:31.094 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:31.097 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-04-29 07:25:31.120 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) @@ -2019,11 +2030,239 @@ 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-04-29 07:13:50.073 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: 16 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:13:50.090 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:50.091 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:50.092 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-04-29 07:13:50.101 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: 17 Key: k, toWrite=0, interested=0} +2024-04-29 07:25:31.125 [INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.262 s - in net.spy.memcached.AsciiCancellationTest +[INFO] Running net.spy.memcached.transcoders.SerializingTranscoderTest +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-04-29 07:25:31.142 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:31.860 INFO net.spy.memcached.transcoders.SerializingTranscoder: Compression increased the size of java.lang.String from 57 to 73 +2024-04-29 07:25:32.108 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.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) + 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.TestResult$1.protect(TestResult.java:122) + at junit.framework.TestResult.runProtected(TestResult.java:142) + at junit.framework.TestResult.run(TestResult.java:125) + at junit.framework.TestCase.run(TestCase.java:130) + at junit.framework.TestSuite.runTest(TestSuite.java:241) + at junit.framework.TestSuite.run(TestSuite.java:236) + at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) + at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) + at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) + at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) + 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) +2024-04-29 07:25:32.130 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: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) + 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.TestResult$1.protect(TestResult.java:122) + at junit.framework.TestResult.runProtected(TestResult.java:142) + at junit.framework.TestResult.run(TestResult.java:125) + at junit.framework.TestCase.run(TestCase.java:130) + at junit.framework.TestSuite.runTest(TestSuite.java:241) + at junit.framework.TestSuite.run(TestSuite.java:236) + at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) + at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) + at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) + at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) + 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 +2024-04-29 07:25:32.144 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 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) + at junit.framework.TestCase.run(TestCase.java:130) + at junit.framework.TestSuite.runTest(TestSuite.java:241) + at junit.framework.TestSuite.run(TestSuite.java:236) + at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) + at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) + at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) + at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) + 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) +2024-04-29 07:25:32.192 WARN net.spy.memcached.transcoders.SerializingTranscoder: Undecodeable with flags ff00 +[INFO] Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.493 s - in net.spy.memcached.transcoders.SerializingTranscoderTest +[INFO] Running net.spy.memcached.transcoders.TranscoderUtilsTest +[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 s - in net.spy.memcached.transcoders.TranscoderUtilsTest +[INFO] Running net.spy.memcached.transcoders.WhalinV1TranscoderTest +2024-04-29 07:25:33.611 INFO net.spy.memcached.transcoders.WhalinV1Transcoder: Compressed java.util.ArrayList from 17491 to 211 +[INFO] Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.762 s - in net.spy.memcached.transcoders.WhalinV1TranscoderTest +[INFO] Running net.spy.memcached.transcoders.IntegerTranscoderTest +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.transcoders.IntegerTranscoderTest +[INFO] Running net.spy.memcached.transcoders.WhalinTranscoderTest +2024-04-29 07:25:34.170 INFO net.spy.memcached.transcoders.WhalinTranscoder: Compression increased the size of java.lang.String from 57 to 73 +2024-04-29 07:25:34.209 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.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) + 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.TestResult$1.protect(TestResult.java:122) + at junit.framework.TestResult.runProtected(TestResult.java:142) + at junit.framework.TestResult.run(TestResult.java:125) + at junit.framework.TestCase.run(TestCase.java:130) + at junit.framework.TestSuite.runTest(TestSuite.java:241) + at junit.framework.TestSuite.run(TestSuite.java:236) + at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) + at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) + at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) + at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) + 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) +2024-04-29 07:25:34.246 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.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) + 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.TestResult$1.protect(TestResult.java:122) + at junit.framework.TestResult.runProtected(TestResult.java:142) + at junit.framework.TestResult.run(TestResult.java:125) + at junit.framework.TestCase.run(TestCase.java:130) + at junit.framework.TestSuite.runTest(TestSuite.java:241) + at junit.framework.TestSuite.run(TestSuite.java:236) + at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) + at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) + at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) + at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) + 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) +2024-04-29 07:25:34.273 WARN net.spy.memcached.transcoders.WhalinTranscoder: Cannot handle data with flags 0 +2024-04-29 07:25:34.310 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.621 s - in net.spy.memcached.transcoders.WhalinTranscoderTest +[INFO] Running net.spy.memcached.transcoders.LongTranscoderTest +2024-04-29 07:25:34.766 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.011 s - in net.spy.memcached.transcoders.LongTranscoderTest +[INFO] Running net.spy.memcached.transcoders.CachedDataTest +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.017 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.067 s - in net.spy.memcached.transcoders.TranscodeServiceTest +[INFO] Running net.spy.memcached.transcoders.BaseSerializingTranscoderTest +2024-04-29 07:25:35.107 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:525) + 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 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) + at junit.framework.TestCase.run(TestCase.java:130) + at junit.framework.TestSuite.runTest(TestSuite.java:241) + at junit.framework.TestSuite.run(TestSuite.java:236) + at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) + at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) + at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) + at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) + at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) + 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.793 s - in net.spy.memcached.transcoders.BaseSerializingTranscoderTest +[INFO] Running net.spy.memcached.DefaultHashAlgorithmTest +[INFO] Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.116 s - in net.spy.memcached.DefaultHashAlgorithmTest +[INFO] Running net.spy.memcached.QueueOverflowTest +2024-04-29 07:25:36.100 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:36.109 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-04-29 07:25:36.124 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:36.126 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:36.130 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-04-29 07:25:36.173 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:36.174 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:36.179 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-04-29 07:25:36.196 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:36.199 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:36.203 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: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.16 s - in net.spy.memcached.QueueOverflowTest +[INFO] Running net.spy.memcached.ToStringTest +2024-04-29 07:25:36.238 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.014 s - in net.spy.memcached.ToStringTest +[INFO] Running net.spy.memcached.RedistributeFailureModeTest +2024-04-29 07:25:36.364 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:36.375 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-04-29 07:25:36.376 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-04-29 07:25:36.407 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) @@ -2031,23 +2270,20 @@ 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-04-29 07:13:50.108 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: 17 Key: k, toWrite=0, interested=0}, attempt 1. -[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.466 s - in net.spy.memcached.BinaryCancellationTest -[INFO] Running net.spy.memcached.compat.log.LoggingTest -2024-04-29 07:13:50.122 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:50.158 WARN net.spy.memcached.compat.log.LoggingTest: warn message -2024-04-29 07:13:50.165 WARN net.spy.memcached.compat.log.LoggingTest: test message -2024-04-29 07:13:50.165 ERROR net.spy.memcached.compat.log.LoggingTest: error message -2024-04-29 07:13:50.166 ERROR net.spy.memcached.compat.log.LoggingTest: test message -2024-04-29 07:13:50.166 FATAL net.spy.memcached.compat.log.LoggingTest: fatal message -2024-04-29 07:13:50.166 FATAL net.spy.memcached.compat.log.LoggingTest: test message -2024-04-29 07:13:50.169 INFO net.spy.memcached.compat.log.LoggingTest: info message -2024-04-29 07:13:50.170 WARN net.spy.memcached.compat.log.LoggingTest: warn message -2024-04-29 07:13:50.170 ERROR net.spy.memcached.compat.log.LoggingTest: error message -2024-04-29 07:13:50.179 FATAL net.spy.memcached.compat.log.LoggingTest: fatal message -2024-04-29 07:13:50.179 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-04-29 07:25:36.410 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-04-29 07:25:36.759 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:36.761 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-04-29 07:25:36.769 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.551 s - in net.spy.memcached.RedistributeFailureModeTest +[INFO] Running net.spy.memcached.AddrUtilTest +2024-04-29 07:25:36.902 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +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) @@ -2069,19 +2305,203 @@ 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) -2024-04-29 07:13:50.197 INFO net.spy.memcached.compat.log.LoggingTest: info message -Apr 29, 2024 7:13:50 AM net.spy.memcached.compat.log.LoggingTest testSunLogger -INFO: info message -Apr 29, 2024 7:13:50 AM net.spy.memcached.compat.log.LoggingTest testSunLogger -WARNING: warn message -Apr 29, 2024 7:13:50 AM net.spy.memcached.compat.log.LoggingTest testSunLogger -SEVERE: error message -Apr 29, 2024 7:13:50 AM net.spy.memcached.compat.log.LoggingTest testSunLogger -SEVERE: fatal message -Apr 29, 2024 7:13:50 AM 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.116 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.395 s - in net.spy.memcached.ConnectionFactoryBuilderTest +[INFO] Running net.spy.memcached.ConsistentHashingTest +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.253 s - in net.spy.memcached.ConsistentHashingTest +[INFO] Running net.spy.memcached.TimeoutNowriteTest +2024-04-29 07:25:37.816 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:37.822 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@197a632 +Trying to get: +Received a line. +Complete. + +Op timed out is true +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.132 s - in net.spy.memcached.TimeoutNowriteTest +[INFO] Running net.spy.memcached.ArrayModNodeLocatorTest +2024-04-29 07:25:38.947 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.207 s - in net.spy.memcached.ArrayModNodeLocatorTest +[INFO] Running net.spy.memcached.MemcachedClientConstructorTest +2024-04-29 07:25:39.324 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:39.326 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-04-29 07:25:39.350 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:39.365 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:39.379 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-04-29 07:25:39.419 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:39.429 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:39.437 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-04-29 07:25:39.502 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.205 s - in net.spy.memcached.MemcachedClientConstructorTest +[INFO] Running net.spy.memcached.CacheMapTest +[INFO] Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.417 s - in net.spy.memcached.CacheMapTest +[INFO] Running net.spy.memcached.KetamaNodeKeyFormatterTest +[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.KetamaNodeKeyFormatterTest +[INFO] Running net.spy.memcached.ObserverTest +2024-04-29 07:25:40.159 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:40.161 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-04-29 07:25:40.176 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:40.178 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-04-29 07:25:40.190 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:40.216 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:40.218 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:40.223 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-04-29 07:25:40.255 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:40.257 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-04-29 07:25:40.263 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:40.283 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:40.284 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:40.286 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: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.169 s - in net.spy.memcached.ObserverTest +[INFO] Running net.spy.memcached.MemcachedConnectionTest +2024-04-29 07:25:40.316 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:40.375 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:40.377 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-04-29 07:25:40.416 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) + 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-04-29 07:25:40.419 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-04-29 07:25:40.421 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:40.432 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.103 s - in net.spy.memcached.MemcachedConnectionTest +[INFO] Running net.spy.memcached.CASMutatorTest +2024-04-29 07:25:40.539 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:40.555 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-04-29 07:25:40.568 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:40.570 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:40.582 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-04-29 07:25:40.630 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:40.631 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:40.633 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-04-29 07:25:41.479 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:41.480 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:41.483 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-04-29 07:25:41.512 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:41.514 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:41.519 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-04-29 07:25:41.533 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.549 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.579 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.607 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.627 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.655 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.683 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.707 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.731 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.759 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.783 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.811 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.831 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.848 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.871 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.887 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.905 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.927 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.959 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:41.983 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.011 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.035 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.059 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.094 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.123 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.151 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.175 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.203 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.231 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.259 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.287 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.311 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.339 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.367 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.395 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.419 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.447 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.471 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.495 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.523 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.555 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.587 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.619 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.655 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.687 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.719 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.751 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.783 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.819 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.851 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 +2024-04-29 07:25:42.879 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:42.882 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-04-29 07:25:42.890 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:42.930 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:42.933 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-04-29 07:25:42.934 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:42.999 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:43.002 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-04-29 07:25:43.006 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:43.023 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:43.025 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:43.033 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-04-29 07:25:43.106 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:43.110 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:43.113 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-04-29 07:25:43.142 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:43.144 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:43.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-04-29 07:25:43.156 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:43.158 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-04-29 07:25:43.164 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.705 s - in net.spy.memcached.CASMutatorTest +[INFO] Running net.spy.memcached.LongClientTest +2024-04-29 07:25:43.210 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:43.257 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:43.271 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-04-29 07:25:43.288 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:43.299 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-04-29 07:25:43.314 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:44.443 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-04-29 07:25:44.445 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) + 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-04-29 07:25:44.448 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. +2024-04-29 07:25:50.226 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:50.228 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:50.230 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: 7.02 s - in net.spy.memcached.LongClientTest +[INFO] Running net.spy.memcached.KetamaConnectionFactoryTest +2024-04-29 07:25:50.254 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 s - in net.spy.memcached.KetamaConnectionFactoryTest +[INFO] Running net.spy.memcached.tapmessage.ResponseMessageWrongOrderTest +[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.467 s - in net.spy.memcached.tapmessage.ResponseMessageWrongOrderTest +[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.TapDeleteTest +[INFO] Tests run: 14, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 s - in net.spy.memcached.tapmessage.TapDeleteTest +[INFO] Running net.spy.memcached.compat.log.LoggingTest +2024-04-29 07:25:50.858 WARN net.spy.memcached.compat.log.LoggingTest: warn message +2024-04-29 07:25:50.859 WARN net.spy.memcached.compat.log.LoggingTest: test message +2024-04-29 07:25:50.860 ERROR net.spy.memcached.compat.log.LoggingTest: error message +2024-04-29 07:25:50.861 ERROR net.spy.memcached.compat.log.LoggingTest: test message +2024-04-29 07:25:50.863 FATAL net.spy.memcached.compat.log.LoggingTest: fatal message +2024-04-29 07:25:50.864 FATAL net.spy.memcached.compat.log.LoggingTest: test message +2024-04-29 07:25:50.869 INFO net.spy.memcached.compat.log.LoggingTest: info message +2024-04-29 07:25:50.871 WARN net.spy.memcached.compat.log.LoggingTest: warn message +2024-04-29 07:25:50.872 ERROR net.spy.memcached.compat.log.LoggingTest: error message +2024-04-29 07:25:50.873 FATAL net.spy.memcached.compat.log.LoggingTest: fatal message +2024-04-29 07:25:50.874 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) @@ -2103,13 +2523,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 29, 2024 7:13:50 AM net.spy.memcached.compat.log.SunLogger log -SEVERE: test null -Apr 29, 2024 7:13:50 AM net.spy.memcached.compat.log.SunLogger log -SEVERE: null message with exception and no requestor +2024-04-29 07:25:50.884 INFO net.spy.memcached.compat.log.LoggingTest: info message +Apr 29, 2024 7:25:50 AM net.spy.memcached.compat.log.LoggingTest testSunLogger +INFO: info message +Apr 29, 2024 7:25:51 AM net.spy.memcached.compat.log.LoggingTest testSunLogger +WARNING: warn message +Apr 29, 2024 7:25:51 AM net.spy.memcached.compat.log.LoggingTest testSunLogger +SEVERE: error message +Apr 29, 2024 7:25:51 AM net.spy.memcached.compat.log.LoggingTest testSunLogger +SEVERE: fatal message +Apr 29, 2024 7:25:51 AM 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) @@ -2132,14 +2558,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.229 s - in net.spy.memcached.compat.log.LoggingTest -[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) +Apr 29, 2024 7:25:51 AM net.spy.memcached.compat.log.SunLogger log +SEVERE: test null +Apr 29, 2024 7:25:51 AM 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) @@ -2161,30 +2585,15 @@ 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.028 s - in net.spy.memcached.AddrUtilTest -[INFO] Running net.spy.memcached.ConsistentHashingTest -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.125 s - in net.spy.memcached.ConsistentHashingTest -[INFO] Running net.spy.memcached.ObserverTest -2024-04-29 07:13:50.571 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:50.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 -2024-04-29 07:13:50.583 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:50.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-04-29 07:13:50.586 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:50.616 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:50.617 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-04-29 07:13:50.622 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:50.631 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:50.632 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:50.633 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-04-29 07:13:50.654 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:50.658 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:50.659 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-04-29 07:13:50.694 INFO[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.117 s - in net.spy.memcached.ObserverTest -[INFO] Running net.spy.memcached.MemcachedConnectionTest - net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:13:50.713 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:50.719 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-04-29 07:13:50.731 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.212 s - in net.spy.memcached.compat.log.LoggingTest +[INFO] Running net.spy.memcached.spring.MemcachedClientFactoryBeanTest +2024-04-29 07:25:51.280 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:51.282 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-04-29 07:25:51.287 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.039 s - in net.spy.memcached.spring.MemcachedClientFactoryBeanTest +[INFO] Running net.spy.memcached.ConnectionFactoryTest +2024-04-29 07:25:51.307 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) @@ -2192,13 +2601,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) -2024-04-29 07:13:50.733 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-04-29 07:13:50.739 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:13:50.740 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.035 s - in net.spy.memcached.MemcachedConnectionTest -[INFO] Running net.spy.memcached.protocol.ascii.OperationFactoryTest -2024-04-29 07:13:54.751 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-04-29 07:13:54.752 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} +2024-04-29 07:25:51.309 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-04-29 07:25:51.315 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) @@ -2206,9 +2610,16 @@ 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-04-29 07:13:54.753 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. -2024-04-29 07:14:02.811 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-04-29 07:14:02.813 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} +2024-04-29 07:25:51.317 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: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.036 s - in net.spy.memcached.ConnectionFactoryTest +[INFO] Running net.spy.memcached.util.StringUtilsTest +[INFO] Tests run: 16, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.013 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.279 s - in net.spy.memcached.util.CacheLoaderTest +[INFO] Running net.spy.memcached.TimeoutTest +2024-04-29 07:25:51.800 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:51.802 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-04-29 07:25:51.827 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) @@ -2216,35 +2627,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) -2024-04-29 07:14:02.814 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 3. -[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.506 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.005 s - in net.spy.memcached.protocol.ascii.AsciiToStringTest -[INFO] Running net.spy.memcached.protocol.ascii.OperationExceptionTest -[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.protocol.ascii.OperationExceptionTest -[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.binary.OperationFactoryTest -[INFO] Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 13.332 s - in net.spy.memcached.protocol.binary.OperationFactoryTest -[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.BinaryToStringTest -[INFO] Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.076 s - in net.spy.memcached.protocol.binary.BinaryToStringTest -[INFO] Running net.spy.memcached.DefaultHashAlgorithmTest -[INFO] Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 s - in net.spy.memcached.DefaultHashAlgorithmTest -[INFO] Running net.spy.memcached.KetamaNodeLocatorTest -[INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.827 s - in net.spy.memcached.KetamaNodeLocatorTest -[INFO] Running net.spy.memcached.MemcachedClientConstructorTest -2024-04-29 07:14:18.813 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:18.823 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-04-29 07:14:18.842 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:18.843 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:18.844 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-04-29 07:14:18.883 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:18.887 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:18.888 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-04-29 07:14:18.895 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-04-29 07:14:18.896 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} +2024-04-29 07:25:51.834 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-04-29 07:25:51.854 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:51.862 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:51.864 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-04-29 07:25:51.883 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} 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) @@ -2252,15 +2639,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) -2024-04-29 07:14:18.897 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 4. -2024-04-29 07:14:18.930 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.124 s - in net.spy.memcached.MemcachedClientConstructorTest -[INFO] Running net.spy.memcached.CacheMapTest -[INFO] Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.131 s - in net.spy.memcached.CacheMapTest -[INFO] Running net.spy.memcached.TimeoutTest -2024-04-29 07:14:19.123 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:19.124 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-04-29 07:14:19.155 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-04-29 07:25:51.886 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. +2024-04-29 07:25:51.914 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:51.918 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:51.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 +2024-04-29 07:25:51.935 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) @@ -2268,11 +2651,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) -2024-04-29 07:14:19.156 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. -2024-04-29 07:14:19.182 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:19.186 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:19.188 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-04-29 07:14:19.211 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-04-29 07:25:51.937 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-04-29 07:25:51.966 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:51.970 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:51.972 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-04-29 07:25:51.987 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) @@ -2280,11 +2663,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) -2024-04-29 07:14:19.212 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. -2024-04-29 07:14:19.242 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:19.243 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-04-29 07:14:19.246 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:19.271 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-04-29 07:25:51.990 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-04-29 07:25:52.014 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.023 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.025 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-04-29 07:25:52.047 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} 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) @@ -2292,11 +2675,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) -2024-04-29 07:14:19.272 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-04-29 07:14:19.295 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:19.297 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-04-29 07:14:19.299 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:19.319 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} +2024-04-29 07:25:52.058 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. +2024-04-29 07:25:52.080 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.082 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-04-29 07:25:52.102 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.119 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) @@ -2304,11 +2687,16 @@ 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-04-29 07:14:19.320 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-04-29 07:14:19.350 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:19.354 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:19.355 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-04-29 07:14:19.383 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-04-29 07:25:52.122 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. +2024-04-29 07:25:52.138[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.329 s - in net.spy.memcached.TimeoutTest + INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Running net.spy.memcached.BinaryCancellationTest +2024-04-29 07:25:52.171 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.173 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-04-29 07:25:52.193 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.194 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.202 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-04-29 07:25:52.219 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) @@ -2316,11 +2704,14 @@ 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-04-29 07:14:19.384 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. -2024-04-29 07:14:19.399 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:19.400 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-04-29 07:14:19.406 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:19.419 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-04-29 07:25:52.221 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-04-29 07:25:52.238 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.240 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.241 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-04-29 07:25:52.264 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.266 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-04-29 07:25:52.274 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.295 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: 19 Key: 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) @@ -2328,14 +2719,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) -2024-04-29 07:14:19.420 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. -[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.299 s - in net.spy.memcached.TimeoutTest -[INFO] Running net.spy.memcached.RedistributeFailureModeTest -2024-04-29 07:14:19.446 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:19.471 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:19.472 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-04-29 07:14:19.473 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-04-29 07:14:19.511 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} +2024-04-29 07:25:52.298 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: 19 Key: k, toWrite=0, interested=0}, attempt 1. +2024-04-29 07:25:52.306 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.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-04-29 07:25:52.314 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.335 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: 4 Opaque: 20 Key: x Cas: 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) @@ -2343,168 +2731,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) -2024-04-29 07:14:19.512 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-04-29 07:14:19.727 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:19.730 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:19.731 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: 0.399 s - in net.spy.memcached.RedistributeFailureModeTest -[INFO] Running net.spy.memcached.LongClientTest -2024-04-29 07:14:19.874 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:19.895 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:19.897 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-04-29 07:14:19.910 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:19.911 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-04-29 07:14:19.914 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:19.927 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for k0. -2024-04-29 07:14:19.928 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for k1. -2024-04-29 07:14:19.929 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for k2. -2024-04-29 07:14:19.930 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for k3. -2024-04-29 07:14:22.506 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:22.507 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:22.508 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-04-29 07:14:22.538 INFO[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.657 s - in net.spy.memcached.LongClientTest - net.spy.memcached.MemcachedConnection: Shut down memcached client -[INFO] Running net.spy.memcached.tapmessage.ResponseMessageFixedOrderTest -[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.092 s - in net.spy.memcached.tapmessage.ResponseMessageFixedOrderTest -[INFO] Running net.spy.memcached.tapmessage.TapDeleteTest -[INFO] Tests run: 14, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.01 s - in net.spy.memcached.tapmessage.TapDeleteTest -[INFO] Running net.spy.memcached.tapmessage.ResponseMessageWrongOrderTest -[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.018 s - in net.spy.memcached.tapmessage.ResponseMessageWrongOrderTest -[INFO] Running net.spy.memcached.MemcachedNodeROImplTest -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 s - in net.spy.memcached.MemcachedNodeROImplTest -[INFO] Running net.spy.memcached.MetricsTest -2024-04-29 07:14:22.760 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-04-29 07:14:22.855 INFO net.spy.memcached.ConnectionFactoryBuilder$1: Metric collection enabled (Profile PERFORMANCE). -2024-04-29 07:14:22.864 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:22.865 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-04-29 07:14:22.883 WARN net.spy.memcached.MemcachedConnection: Could not redistribute to another node, retrying primary node for metrics:test. -2024-04-29 07:14:22.914 [INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.164 s - in net.spy.memcached.MetricsTest -INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[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.TimeoutNowriteTest -2024-04-29 07:14:22.935 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:22.936 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@150f9e -Trying to get: -Received a line. -Complete. - -Op timed out is true -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.109 s - in net.spy.memcached.TimeoutNowriteTest -[INFO] Running net.spy.memcached.util.StringUtilsTest -2024-04-29 07:14:24.066 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -[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.util.CacheLoaderTest -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.307 s - in net.spy.memcached.util.CacheLoaderTest -[INFO] Running net.spy.memcached.ArrayModNodeLocatorTest -[INFO] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 s - in net.spy.memcached.ArrayModNodeLocatorTest -[INFO] Running net.spy.memcached.CASMutatorTest -2024-04-29 07:14:24.468 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:24.469 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-04-29 07:14:24.477 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:24.478 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-04-29 07:14:24.483 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:24.511 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:24.512 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:24.513 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-04-29 07:14:24.739 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:24.740 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-04-29 07:14:24.741 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:24.758 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:24.759 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:24.760 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-04-29 07:14:24.783 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:24.810 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:24.838 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:24.862 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:24.894 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:24.922 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:24.951 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:24.974 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.002 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.026 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.058 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.090 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.114 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.146 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.175 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.183 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.194 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.201 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.207 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.214 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.219 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.231 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.237 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.248 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.253 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.260 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.266 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.270 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.275 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.286 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.292 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.297 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.302 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.307 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.312 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.316 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.321 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.326 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.332 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.336 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.341 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.346 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.351 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.356 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.360 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.365 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.371 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.376 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.380 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.384 ERROR net.spy.memcached.transcoders.LongTranscoder: Unexpected flags for long: 0 wanted 768 -2024-04-29 07:14:25.395 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.396 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.397 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-04-29 07:14:25.434 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.440 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.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-04-29 07:14:25.482 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.483 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.484 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-04-29 07:14:25.510 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.511 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.512 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-04-29 07:14:25.562 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.563 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.564 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-04-29 07:14:25.598 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.606 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.608 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-04-29 07:14:25.620 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.621 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-04-29 07:14:25.666 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.690 INFO net.spy.memcached.MemcachedConnection[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.205 s - in net.spy.memcached.CASMutatorTest -: 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.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.ConnectionFactoryBuilderTest -[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.ConnectionFactoryBuilderTest -[INFO] Running net.spy.memcached.AsciiCancellationTest -2024-04-29 07:14:25.768 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.769 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-04-29 07:14:25.776 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.777 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-04-29 07:14:25.781 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.790 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-04-29 07:25:52.338 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: 4 Opaque: 20 Key: x Cas: 0, toWrite=0, interested=0}, attempt 1. +2024-04-29 07:25:52.350 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.352 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.354 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-04-29 07:25:52.375 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: 21 Delay: 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) @@ -2512,14 +2743,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) -2024-04-29 07:14:25.791 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. -2024-04-29 07:14:25.807 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.808 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.809 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-04-29 07:14:25.816 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.816 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-04-29 07:14:25.818 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.823 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} +2024-04-29 07:25:52.378 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: 21 Delay: 0, toWrite=0, interested=0}, attempt 1. +2024-04-29 07:25:52.394 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.396 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.398 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-04-29 07:25:52.419 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: 22 Delay: 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) @@ -2527,11 +2755,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) -2024-04-29 07:14:25.824 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-04-29 07:14:25.842 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.843 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.844 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-04-29 07:14:25.855 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: delete Key: x, toWrite=0, interested=0} +2024-04-29 07:25:52.422 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: 22 Delay: 0, toWrite=0, interested=0}, attempt 1. +2024-04-29 07:25:52.431 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.432 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.442 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-04-29 07:25:52.463 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: 23 Key: x Cas: 3 Exp: 0 Flags: 0 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) @@ -2539,11 +2767,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) -2024-04-29 07:14:25.856 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: delete Key: x, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:14:25.871 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.872 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-04-29 07:14:25.878 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.883 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: -1, toWrite=0, interested=0} +2024-04-29 07:25:52.467 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: 23 Key: x Cas: 3 Exp: 0 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. +2024-04-29 07:25:52.478 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.487 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-04-29 07:25:52.489 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) @@ -2551,11 +2778,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) -2024-04-29 07:14:25.884 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: -1, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:14:25.898 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.899 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.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-04-29 07:14:25.915 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-04-29 07:25:52.494 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 3. +2024-04-29 07:25:52.496 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.498 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-04-29 07:25:52.519 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: 24 Key: x Cas: 0 Exp: 3 Flags: 0 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) @@ -2563,11 +2789,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) -2024-04-29 07:14:25.916 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. -2024-04-29 07:14:25.926 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.931 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.932 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-04-29 07:14:25.947 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: x Cas Value: 3 Flags: 0 Exp: 0 Data Length: 1, toWrite=0, interested=0} +2024-04-29 07:25:52.522 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: 24 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. +2024-04-29 07:25:52.529 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.534 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.536 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-04-29 07:25:52.555 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: 25 Key: x Cas: 0 Exp: 3 Flags: 0 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) @@ -2575,11 +2801,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) -2024-04-29 07:14:25.948 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: x Cas Value: 3 Flags: 0 Exp: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:14:25.964 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:25.966 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:25.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-04-29 07:14:25.983 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} +2024-04-29 07:25:52.558 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: 25 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. +2024-04-29 07:25:52.563 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.571 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.573 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-04-29 07:25:52.595 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) @@ -2587,11 +2813,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) -2024-04-29 07:14:25.984 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-04-29 07:14:25.994 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:26.002 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:26.003 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-04-29 07:14:26.011 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-04-29 07:25:52.602 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. +2024-04-29 07:25:52.618 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.622 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.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 +2024-04-29 07:25:52.643 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: 29 Key: x Cas: 0 Exp: 3 Flags: 0 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) @@ -2599,11 +2825,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) -2024-04-29 07:14:26.012 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. -2024-04-29 07:14:26.022 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:26.025 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:26.026 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-04-29 07:14:26.047 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-04-29 07:25:52.646 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: 29 Key: x Cas: 0 Exp: 3 Flags: 0 Data Length: 1, toWrite=0, interested=0}, attempt 1. +2024-04-29 07:25:52.655 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:52.659 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:52.661 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-04-29 07:25:52.683 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: 30 Key: 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) @@ -2611,11 +2837,30 @@ 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-04-29 07:14:26.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: k2 kExp: 0, toWrite=0, interested=0}, attempt 1. -2024-04-29 07:14:26.062 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:26.067 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:26.068 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-04-29 07:14:26.087 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-04-29 07:25:52.685 WARN [INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.512 s - in net.spy.memcached.BinaryCancellationTest +[INFO] Running net.spy.memcached.internal.CheckedOperationTimeoutExceptionTest +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: 30 Key: k, toWrite=0, interested=0}, attempt 1. +2024-04-29 07:25:52.699 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.006 s - in net.spy.memcached.internal.CheckedOperationTimeoutExceptionTest +[INFO] Running net.spy.memcached.internal.SingleElementInfiniteIteratorTest +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 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.552 s - in net.spy.memcached.internal.ListenableFutureTest +[INFO] Running net.spy.memcached.MetricsTest +2024-04-29 07:25:53.360 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-04-29 07:25:53.518 INFO net.spy.memcached.ConnectionFactoryBuilder$1: Metric collection enabled (Profile PERFORMANCE). +2024-04-29 07:25:53.529 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:53.539 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-04-29 07:25:53.542 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.182 s - in net.spy.memcached.MetricsTest +[INFO] Running net.spy.memcached.KetamaNodeLocatorTest +2024-04-29 07:25:53.566 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +2024-04-29 07:25:55.339 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-04-29 07:25:55.340 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-04-29 07:25:55.347 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) @@ -2623,11 +2868,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) -2024-04-29 07:14:26.088 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. -2024-04-29 07:14:26.100 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:26.101 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:26.102 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-04-29 07:14:26.112 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-04-29 07:25:55.350 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. +2024-04-29 07:25:55.356 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) @@ -2635,18 +2877,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) -2024-04-29 07:14:26.113 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. -[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.302 s - in net.spy.memcached.AsciiCancellationTest -[INFO] Running net.spy.memcached.spring.MemcachedClientFactoryBeanTest -2024-04-29 07:14:26.130 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client -2024-04-29 07:14:26.147 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 -2024-04-29 07:14:26.148 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-04-29 07:14:26.150 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.023 s - in net.spy.memcached.spring.MemcachedClientFactoryBeanTest -[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.SerializingTranscoderTest -2024-04-29 07:14:26.175 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-04-29 07:25:55.366 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. +[INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.586 s - in net.spy.memcached.KetamaNodeLocatorTest +[INFO] Running net.spy.memcached.CancelFailureModeTest +2024-04-29 07:25:56.169 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:56.175 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-04-29 07:25:56.177 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-04-29 07:25:56.200 INFO net.spy.memcached.MemcachedConnection: Setting retryQueueSize to -1 +2024-04-29 07:25:56.202 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-04-29 07:25:56.206 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) @@ -2654,8 +2893,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) -2024-04-29 07:14:26.176 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. -2024-04-29 07:14:26.176 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-04-29 07:25:56.208 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.145 s - in net.spy.memcached.CancelFailureModeTest +[INFO] Running net.spy.memcached.protocol.binary.BinaryToStringTest +2024-04-29 07:25:56.330 INFO net.spy.memcached.MemcachedConnection: Shut down memcached client +[INFO] Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.216 s - in net.spy.memcached.protocol.binary.BinaryToStringTest +[INFO] Running net.spy.memcached.protocol.binary.OperationFactoryTest +2024-04-29 07:26:03.398 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-04-29 07:26:03.400 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-04-29 07:26:03.401 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) @@ -2663,215 +2909,111 @@ 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-04-29 07:14:26.177 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-04-29 07:14:26.281 INFO net.spy.memcached.transcoders.SerializingTranscoder: Compression increased the size of java.lang.String from 57 to 73 -2024-04-29 07:14:26.401 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.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) - 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.TestResult$1.protect(TestResult.java:122) - at junit.framework.TestResult.runProtected(TestResult.java:142) - at junit.framework.TestResult.run(TestResult.java:125) - at junit.framework.TestCase.run(TestCase.java:130) - at junit.framework.TestSuite.runTest(TestSuite.java:241) - at junit.framework.TestSuite.run(TestSuite.java:236) - at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) - at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) - at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) - at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) - 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) -2024-04-29 07:14:26.413 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: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) - 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.TestResult$1.protect(TestResult.java:122) - at junit.framework.TestResult.runProtected(TestResult.java:142) - at junit.framework.TestResult.run(TestResult.java:125) - at junit.framework.TestCase.run(TestCase.java:130) - at junit.framework.TestSuite.runTest(TestSuite.java:241) - at junit.framework.TestSuite.run(TestSuite.java:236) - at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) - at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) - at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) - at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) - 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 -2024-04-29 07:14:26.424 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 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) - at junit.framework.TestCase.run(TestCase.java:130) - at junit.framework.TestSuite.runTest(TestSuite.java:241) - at junit.framework.TestSuite.run(TestSuite.java:236) - at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) - at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) - at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) - at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) - 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) -2024-04-29 07:14:26.456 WARN net.spy.memcached.transcoders.SerializingTranscoder: Undecodeable with flags ff00 -[INFO] Tests run: 28, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.509 s - in net.spy.memcached.transcoders.SerializingTranscoderTest -[INFO] Running net.spy.memcached.transcoders.TranscoderUtilsTest -[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in net.spy.memcached.transcoders.TranscoderUtilsTest -[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.IntegerTranscoderTest -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.009 s - in net.spy.memcached.transcoders.IntegerTranscoderTest -[INFO] Running net.spy.memcached.transcoders.WhalinV1TranscoderTest -2024-04-29 07:14:26.833 INFO net.spy.memcached.transcoders.WhalinV1Transcoder: Compressed java.util.ArrayList from 17491 to 202 -[INFO] Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.133 s - in net.spy.memcached.transcoders.WhalinV1TranscoderTest -[INFO] Running net.spy.memcached.transcoders.BaseSerializingTranscoderTest -2024-04-29 07:14:26.955 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:525) - 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 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) - at junit.framework.TestCase.run(TestCase.java:130) - at junit.framework.TestSuite.runTest(TestSuite.java:241) - at junit.framework.TestSuite.run(TestSuite.java:236) - at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) - at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) - at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) - at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) - 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.107 s - in net.spy.memcached.transcoders.BaseSerializingTranscoderTest -[INFO] Running net.spy.memcached.transcoders.WhalinTranscoderTest -2024-04-29 07:14:27.104 INFO net.spy.memcached.transcoders.WhalinTranscoder: Compression increased the size of java.lang.String from 57 to 73 -2024-04-29 07:14:27.115 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.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) - 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.TestResult$1.protect(TestResult.java:122) - at junit.framework.TestResult.runProtected(TestResult.java:142) - at junit.framework.TestResult.run(TestResult.java:125) - at junit.framework.TestCase.run(TestCase.java:130) - at junit.framework.TestSuite.runTest(TestSuite.java:241) - at junit.framework.TestSuite.run(TestSuite.java:236) - at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) - at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) - at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) - at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) - 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) -2024-04-29 07:14:27.118 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.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) - 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.TestResult$1.protect(TestResult.java:122) - at junit.framework.TestResult.runProtected(TestResult.java:142) - at junit.framework.TestResult.run(TestResult.java:125) - at junit.framework.TestCase.run(TestCase.java:130) - at junit.framework.TestSuite.runTest(TestSuite.java:241) - at junit.framework.TestSuite.run(TestSuite.java:236) - at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:90) - at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273) - at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238) - at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159) - at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384) - 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) -2024-04-29 07:14:27.120 WARN net.spy.memcached.transcoders.WhalinTranscoder: Cannot handle data with flags 0 -2024-04-29 07:14:27.124 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.111 s - in net.spy.memcached.transcoders.WhalinTranscoderTest -[INFO] Running net.spy.memcached.transcoders.LongTranscoderTest -2024-04-29 07:14:27.230 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.001 s - in net.spy.memcached.transcoders.LongTranscoderTest -[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.ToStringTest -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in net.spy.memcached.ToStringTest +2024-04-29 07:26:03.408 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 3. +2024-04-29 07:26:03.409 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) + 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-04-29 07:26:03.415 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 3. +2024-04-29 07:26:08.578 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-04-29 07:26:08.580 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) + 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-04-29 07:26:08.602 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 4. +2024-04-29 07:26:19.491 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-04-29 07:26:19.493 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-04-29 07:26:19.503 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) + 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-04-29 07:26:19.526 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 4. +2024-04-29 07:26:19.528 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) + 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-04-29 07:26:19.543 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 4. +4/29/24, 7:26:23 AM ============================================================ + + +4/29/24, 7:26:23 AM ============================================================ + + +[INFO] Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 40.579 s - in net.spy.memcached.protocol.binary.OperationFactoryTest +[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.ascii.OperationFactoryTest +2024-04-29 07:26:38.706 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-04-29 07:26:38.708 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) + 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-04-29 07:26:38.717 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 5. +2024-04-29 07:26:49.627 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-04-29 07:26:49.628 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-04-29 07:26:49.638 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) + 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-04-29 07:26:49.640 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 5. +2024-04-29 07:26:49.642 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) + 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-04-29 07:26:49.652 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 5. +4/29/24, 7:26:53 AM ============================================================ + + +4/29/24, 7:26:53 AM ============================================================ + + +2024-04-29 07:27:08.823 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-04-29 07:27:08.825 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) + 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-04-29 07:27:08.835 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 6. +[INFO] Tests run: 13, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 35.105 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.02 s - in net.spy.memcached.protocol.ascii.AsciiToStringTest +[INFO] Running net.spy.memcached.protocol.ascii.BaseOpTest +[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 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.002 s - in net.spy.memcached.protocol.ascii.OperationExceptionTest +[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] [INFO] Results: [INFO] @@ -2880,8 +3022,8 @@ [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ -[INFO] Total time: 54.355 s -[INFO] Finished at: 2024-04-29T07:14:36Z +[INFO] Total time: 02:03 min +[INFO] Finished at: 2024-04-29T07:27:14Z [INFO] ------------------------------------------------------------------------ [ ! -s /build/reproducible-path/spymemcached-2.12.3+dfsg/debian/build/memcached.pid ] || /bin/kill `cat /build/reproducible-path/spymemcached-2.12.3+dfsg/debian/build/memcached.pid` make[1]: Leaving directory '/build/reproducible-path/spymemcached-2.12.3+dfsg' @@ -2907,8 +3049,8 @@ [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ -[INFO] Total time: 1.676 s -[INFO] Finished at: 2024-04-29T07:14:43Z +[INFO] Total time: 5.194 s +[INFO] Finished at: 2024-04-29T07:27:35Z [INFO] ------------------------------------------------------------------------ mh_resolve_dependencies --non-interactive --offline --build -plibspymemcached-java --base-directory=/build/reproducible-path/spymemcached-2.12.3\+dfsg --non-explore Analysing pom.xml... @@ -2935,12 +3077,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/3309/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/3309/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/23005 and its subdirectories -I: Current time: Sun Apr 28 19:15:00 -12 2024 -I: pbuilder-time-stamp: 1714374900 +I: removing directory /srv/workspace/pbuilder/3309 and its subdirectories +I: Current time: Mon Apr 29 21:28:23 +14 2024 +I: pbuilder-time-stamp: 1714375703