Diff of the two buildlogs: -- --- b1/build.log 2021-08-14 22:39:19.469468790 +0000 +++ b2/build.log 2021-08-14 22:41:49.211850336 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Sat Aug 14 10:36:57 -12 2021 -I: pbuilder-time-stamp: 1628980617 +I: Current time: Sat Sep 17 19:02:21 +14 2022 +I: pbuilder-time-stamp: 1663390941 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bullseye-reproducible-base.tgz] I: copying local configuration @@ -16,8 +16,8 @@ I: copying [./sslh_1.20-1.debian.tar.xz] I: Extracting source gpgv: unknown type of key resource 'trustedkeys.kbx' -gpgv: keyblock resource '/tmp/dpkg-verify-sig.tnKaWWeP/trustedkeys.kbx': General error -gpgv: Signature made Fri Sep 20 17:57:42 2019 -12 +gpgv: keyblock resource '/tmp/dpkg-verify-sig.cmEz4YMb/trustedkeys.kbx': General error +gpgv: Signature made Sat Sep 21 19:57:42 2019 +14 gpgv: using RSA key 37942061E068204CA2855C96F55025658A66BF3F gpgv: Can't check signature: No public key dpkg-source: warning: failed to verify signature on ./sslh_1.20-1.dsc @@ -32,135 +32,169 @@ dpkg-source: info: applying t_no_libconfig I: using fakeroot in build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/7967/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/32569/tmp/hooks/D01_modify_environment starting +debug: Running on codethink11-arm64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +Removing 'diversion of /bin/sh to /bin/sh.distrib by dash' +Adding 'diversion of /bin/sh to /bin/sh.distrib by bash' +Removing 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by dash' +Adding 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by 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/32569/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/32569/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='arm64' - DEBIAN_FRONTEND='noninteractive' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:hostcomplete:interactive_comments:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="1" [2]="4" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.1.4(1)-release' + BUILDDIR=/build + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=arm64 + DEBIAN_FRONTEND=noninteractive DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all,-fixfilepath parallel=8' - DISTRIBUTION='' - HOME='/var/lib/jenkins' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION= + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/var/lib/jenkins + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - 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='7967' - PS1='# ' - PS2='> ' + LANG=C + LANGUAGE=nl_BE:nl + LC_ALL=C + MACHTYPE=aarch64-unknown-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=32569 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/tmp.Fv2UGn5HtQ/pbuilderrc_Nb9g --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.Fv2UGn5HtQ/b1 --logfile b1/build.log sslh_1.20-1.dsc' - SUDO_GID='117' - SUDO_UID='110' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - USERNAME='root' - _='/usr/bin/systemd-run' - http_proxy='http://192.168.101.16:3128' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/tmp.Fv2UGn5HtQ/pbuilderrc_X6eU --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.Fv2UGn5HtQ/b2 --logfile b2/build.log --extrapackages usrmerge sslh_1.20-1.dsc' + SUDO_GID=117 + SUDO_UID=110 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + USERNAME=root + _='I: set' + http_proxy=http://192.168.101.16:3128 I: uname -a - Linux codethink10-arm64 4.15.0-153-generic #160-Ubuntu SMP Thu Jul 29 07:06:07 UTC 2021 aarch64 GNU/Linux + Linux i-capture-the-hostname 4.15.0-153-generic #160-Ubuntu SMP Thu Jul 29 07:06:07 UTC 2021 aarch64 GNU/Linux I: ls -l /bin total 5252 - -rwxr-xr-x 1 root root 1282512 Aug 4 08:25 bash - -rwxr-xr-x 3 root root 34808 Jul 20 2020 bunzip2 - -rwxr-xr-x 3 root root 34808 Jul 20 2020 bzcat - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzcmp -> bzdiff - -rwxr-xr-x 1 root root 2225 Jul 20 2020 bzdiff - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzegrep -> bzgrep - -rwxr-xr-x 1 root root 4877 Sep 4 2019 bzexe - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzfgrep -> bzgrep - -rwxr-xr-x 1 root root 3775 Jul 20 2020 bzgrep - -rwxr-xr-x 3 root root 34808 Jul 20 2020 bzip2 - -rwxr-xr-x 1 root root 14264 Jul 20 2020 bzip2recover - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzless -> bzmore - -rwxr-xr-x 1 root root 1297 Jul 20 2020 bzmore - -rwxr-xr-x 1 root root 39832 Sep 22 2020 cat - -rwxr-xr-x 1 root root 64512 Sep 22 2020 chgrp - -rwxr-xr-x 1 root root 60368 Sep 22 2020 chmod - -rwxr-xr-x 1 root root 64528 Sep 22 2020 chown - -rwxr-xr-x 1 root root 138896 Sep 22 2020 cp - -rwxr-xr-x 1 root root 129544 Dec 10 2020 dash - -rwxr-xr-x 1 root root 101384 Sep 22 2020 date - -rwxr-xr-x 1 root root 80984 Sep 22 2020 dd - -rwxr-xr-x 1 root root 89824 Sep 22 2020 df - -rwxr-xr-x 1 root root 143088 Sep 22 2020 dir - -rwxr-xr-x 1 root root 76152 Jul 28 07:09 dmesg - lrwxrwxrwx 1 root root 8 Nov 6 2019 dnsdomainname -> hostname - lrwxrwxrwx 1 root root 8 Nov 6 2019 domainname -> hostname - -rwxr-xr-x 1 root root 35632 Sep 22 2020 echo - -rwxr-xr-x 1 root root 28 Nov 9 2020 egrep - -rwxr-xr-x 1 root root 31512 Sep 22 2020 false - -rwxr-xr-x 1 root root 28 Nov 9 2020 fgrep - -rwxr-xr-x 1 root root 64856 Jul 28 07:09 findmnt - -rwsr-xr-x 1 root root 34824 Feb 26 04:12 fusermount - -rwxr-xr-x 1 root root 178400 Nov 9 2020 grep - -rwxr-xr-x 2 root root 2346 Mar 2 11:30 gunzip - -rwxr-xr-x 1 root root 6376 Mar 2 11:30 gzexe - -rwxr-xr-x 1 root root 93744 Mar 2 11:30 gzip - -rwxr-xr-x 1 root root 18440 Nov 6 2019 hostname - -rwxr-xr-x 1 root root 68720 Sep 22 2020 ln - -rwxr-xr-x 1 root root 52720 Feb 7 2020 login - -rwxr-xr-x 1 root root 143088 Sep 22 2020 ls - -rwxr-xr-x 1 root root 161960 Jul 28 07:09 lsblk - -rwxr-xr-x 1 root root 85200 Sep 22 2020 mkdir - -rwxr-xr-x 1 root root 68744 Sep 22 2020 mknod - -rwxr-xr-x 1 root root 43976 Sep 22 2020 mktemp - -rwxr-xr-x 1 root root 51368 Jul 28 07:09 more - -rwsr-xr-x 1 root root 51360 Jul 28 07:09 mount - -rwxr-xr-x 1 root root 14496 Jul 28 07:09 mountpoint - -rwxr-xr-x 1 root root 134808 Sep 22 2020 mv - lrwxrwxrwx 1 root root 8 Nov 6 2019 nisdomainname -> hostname - lrwxrwxrwx 1 root root 14 Apr 18 03:38 pidof -> /sbin/killall5 - -rwxr-xr-x 1 root root 35720 Sep 22 2020 pwd - lrwxrwxrwx 1 root root 4 Aug 4 08:25 rbash -> bash - -rwxr-xr-x 1 root root 43872 Sep 22 2020 readlink - -rwxr-xr-x 1 root root 68592 Sep 22 2020 rm - -rwxr-xr-x 1 root root 43880 Sep 22 2020 rmdir - -rwxr-xr-x 1 root root 19208 Sep 27 2020 run-parts - -rwxr-xr-x 1 root root 114016 Dec 22 2018 sed - lrwxrwxrwx 1 root root 4 Aug 12 21:25 sh -> dash - -rwxr-xr-x 1 root root 35656 Sep 22 2020 sleep - -rwxr-xr-x 1 root root 72640 Sep 22 2020 stty - -rwsr-xr-x 1 root root 67776 Jul 28 07:09 su - -rwxr-xr-x 1 root root 35672 Sep 22 2020 sync - -rwxr-xr-x 1 root root 535768 Feb 16 21:55 tar - -rwxr-xr-x 1 root root 10568 Sep 27 2020 tempfile - -rwxr-xr-x 1 root root 89120 Sep 22 2020 touch - -rwxr-xr-x 1 root root 31512 Sep 22 2020 true - -rwxr-xr-x 1 root root 14264 Feb 26 04:12 ulockmgr_server - -rwsr-xr-x 1 root root 30880 Jul 28 07:09 umount - -rwxr-xr-x 1 root root 35640 Sep 22 2020 uname - -rwxr-xr-x 2 root root 2346 Mar 2 11:30 uncompress - -rwxr-xr-x 1 root root 143088 Sep 22 2020 vdir - -rwxr-xr-x 1 root root 59584 Jul 28 07:09 wdctl - lrwxrwxrwx 1 root root 8 Nov 6 2019 ypdomainname -> hostname - -rwxr-xr-x 1 root root 1984 Mar 2 11:30 zcat - -rwxr-xr-x 1 root root 1678 Mar 2 11:30 zcmp - -rwxr-xr-x 1 root root 5880 Mar 2 11:30 zdiff - -rwxr-xr-x 1 root root 29 Mar 2 11:30 zegrep - -rwxr-xr-x 1 root root 29 Mar 2 11:30 zfgrep - -rwxr-xr-x 1 root root 2081 Mar 2 11:30 zforce - -rwxr-xr-x 1 root root 7585 Mar 2 11:30 zgrep - -rwxr-xr-x 1 root root 2206 Mar 2 11:30 zless - -rwxr-xr-x 1 root root 1842 Mar 2 11:30 zmore - -rwxr-xr-x 1 root root 4553 Mar 2 11:30 znew -I: user script /srv/workspace/pbuilder/7967/tmp/hooks/D02_print_environment finished + -rwxr-xr-x 1 root root 1282512 Aug 5 2021 bash + -rwxr-xr-x 3 root root 34808 Jul 21 2020 bunzip2 + -rwxr-xr-x 3 root root 34808 Jul 21 2020 bzcat + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzcmp -> bzdiff + -rwxr-xr-x 1 root root 2225 Jul 21 2020 bzdiff + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzegrep -> bzgrep + -rwxr-xr-x 1 root root 4877 Sep 5 2019 bzexe + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzfgrep -> bzgrep + -rwxr-xr-x 1 root root 3775 Jul 21 2020 bzgrep + -rwxr-xr-x 3 root root 34808 Jul 21 2020 bzip2 + -rwxr-xr-x 1 root root 14264 Jul 21 2020 bzip2recover + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzless -> bzmore + -rwxr-xr-x 1 root root 1297 Jul 21 2020 bzmore + -rwxr-xr-x 1 root root 39832 Sep 23 2020 cat + -rwxr-xr-x 1 root root 64512 Sep 23 2020 chgrp + -rwxr-xr-x 1 root root 60368 Sep 23 2020 chmod + -rwxr-xr-x 1 root root 64528 Sep 23 2020 chown + -rwxr-xr-x 1 root root 138896 Sep 23 2020 cp + -rwxr-xr-x 1 root root 129544 Dec 11 2020 dash + -rwxr-xr-x 1 root root 101384 Sep 23 2020 date + -rwxr-xr-x 1 root root 80984 Sep 23 2020 dd + -rwxr-xr-x 1 root root 89824 Sep 23 2020 df + -rwxr-xr-x 1 root root 143088 Sep 23 2020 dir + -rwxr-xr-x 1 root root 76152 Jul 29 2021 dmesg + lrwxrwxrwx 1 root root 8 Nov 8 2019 dnsdomainname -> hostname + lrwxrwxrwx 1 root root 8 Nov 8 2019 domainname -> hostname + -rwxr-xr-x 1 root root 35632 Sep 23 2020 echo + -rwxr-xr-x 1 root root 28 Nov 10 2020 egrep + -rwxr-xr-x 1 root root 31512 Sep 23 2020 false + -rwxr-xr-x 1 root root 28 Nov 10 2020 fgrep + -rwxr-xr-x 1 root root 64856 Jul 29 2021 findmnt + -rwsr-xr-x 1 root root 34824 Feb 27 2021 fusermount + -rwxr-xr-x 1 root root 178400 Nov 10 2020 grep + -rwxr-xr-x 2 root root 2346 Mar 3 2021 gunzip + -rwxr-xr-x 1 root root 6376 Mar 3 2021 gzexe + -rwxr-xr-x 1 root root 93744 Mar 3 2021 gzip + -rwxr-xr-x 1 root root 18440 Nov 8 2019 hostname + -rwxr-xr-x 1 root root 68720 Sep 23 2020 ln + -rwxr-xr-x 1 root root 52720 Feb 8 2020 login + -rwxr-xr-x 1 root root 143088 Sep 23 2020 ls + -rwxr-xr-x 1 root root 161960 Jul 29 2021 lsblk + -rwxr-xr-x 1 root root 85200 Sep 23 2020 mkdir + -rwxr-xr-x 1 root root 68744 Sep 23 2020 mknod + -rwxr-xr-x 1 root root 43976 Sep 23 2020 mktemp + -rwxr-xr-x 1 root root 51368 Jul 29 2021 more + -rwsr-xr-x 1 root root 51360 Jul 29 2021 mount + -rwxr-xr-x 1 root root 14496 Jul 29 2021 mountpoint + -rwxr-xr-x 1 root root 134808 Sep 23 2020 mv + lrwxrwxrwx 1 root root 8 Nov 8 2019 nisdomainname -> hostname + lrwxrwxrwx 1 root root 14 Apr 19 2021 pidof -> /sbin/killall5 + -rwxr-xr-x 1 root root 35720 Sep 23 2020 pwd + lrwxrwxrwx 1 root root 4 Aug 5 2021 rbash -> bash + -rwxr-xr-x 1 root root 43872 Sep 23 2020 readlink + -rwxr-xr-x 1 root root 68592 Sep 23 2020 rm + -rwxr-xr-x 1 root root 43880 Sep 23 2020 rmdir + -rwxr-xr-x 1 root root 19208 Sep 28 2020 run-parts + -rwxr-xr-x 1 root root 114016 Dec 23 2018 sed + lrwxrwxrwx 1 root root 4 Sep 17 19:02 sh -> bash + lrwxrwxrwx 1 root root 4 Sep 17 05:47 sh.distrib -> dash + -rwxr-xr-x 1 root root 35656 Sep 23 2020 sleep + -rwxr-xr-x 1 root root 72640 Sep 23 2020 stty + -rwsr-xr-x 1 root root 67776 Jul 29 2021 su + -rwxr-xr-x 1 root root 35672 Sep 23 2020 sync + -rwxr-xr-x 1 root root 535768 Feb 17 2021 tar + -rwxr-xr-x 1 root root 10568 Sep 28 2020 tempfile + -rwxr-xr-x 1 root root 89120 Sep 23 2020 touch + -rwxr-xr-x 1 root root 31512 Sep 23 2020 true + -rwxr-xr-x 1 root root 14264 Feb 27 2021 ulockmgr_server + -rwsr-xr-x 1 root root 30880 Jul 29 2021 umount + -rwxr-xr-x 1 root root 35640 Sep 23 2020 uname + -rwxr-xr-x 2 root root 2346 Mar 3 2021 uncompress + -rwxr-xr-x 1 root root 143088 Sep 23 2020 vdir + -rwxr-xr-x 1 root root 59584 Jul 29 2021 wdctl + lrwxrwxrwx 1 root root 8 Nov 8 2019 ypdomainname -> hostname + -rwxr-xr-x 1 root root 1984 Mar 3 2021 zcat + -rwxr-xr-x 1 root root 1678 Mar 3 2021 zcmp + -rwxr-xr-x 1 root root 5880 Mar 3 2021 zdiff + -rwxr-xr-x 1 root root 29 Mar 3 2021 zegrep + -rwxr-xr-x 1 root root 29 Mar 3 2021 zfgrep + -rwxr-xr-x 1 root root 2081 Mar 3 2021 zforce + -rwxr-xr-x 1 root root 7585 Mar 3 2021 zgrep + -rwxr-xr-x 1 root root 2206 Mar 3 2021 zless + -rwxr-xr-x 1 root root 1842 Mar 3 2021 zmore + -rwxr-xr-x 1 root root 4553 Mar 3 2021 znew +I: user script /srv/workspace/pbuilder/32569/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -261,7 +295,7 @@ Get: 47 http://deb.debian.org/debian bullseye/main arm64 libwrap0 arm64 7.6.q-31 [58.7 kB] Get: 48 http://deb.debian.org/debian bullseye/main arm64 libwrap0-dev arm64 7.6.q-31 [22.3 kB] Get: 49 http://deb.debian.org/debian bullseye/main arm64 psmisc arm64 23.4-2 [196 kB] -Fetched 21.2 MB in 1s (15.8 MB/s) +Fetched 21.2 MB in 1s (38.0 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package bsdextrautils. (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 ... 19646 files and directories currently installed.) @@ -477,9 +511,42 @@ Building dependency tree... Reading state information... fakeroot is already the newest version (1.25.3-1.1). -0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. +The following additional packages will be installed: + libfile-find-rule-perl libnumber-compare-perl libtext-glob-perl +The following NEW packages will be installed: + libfile-find-rule-perl libnumber-compare-perl libtext-glob-perl usrmerge +0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. +Need to get 59.5 kB of archives. +After this operation, 157 kB of additional disk space will be used. +Get:1 http://deb.debian.org/debian bullseye/main arm64 libnumber-compare-perl all 0.03-1.1 [6956 B] +Get:2 http://deb.debian.org/debian bullseye/main arm64 libtext-glob-perl all 0.11-1 [8888 B] +Get:3 http://deb.debian.org/debian bullseye/main arm64 libfile-find-rule-perl all 0.34-1 [30.6 kB] +Get:4 http://deb.debian.org/debian bullseye/main arm64 usrmerge all 25 [13.0 kB] +debconf: delaying package configuration, since apt-utils is not installed +Fetched 59.5 kB in 0s (1082 kB/s) +Selecting previously unselected package libnumber-compare-perl. +(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 ... 21976 files and directories currently installed.) +Preparing to unpack .../libnumber-compare-perl_0.03-1.1_all.deb ... +Unpacking libnumber-compare-perl (0.03-1.1) ... +Selecting previously unselected package libtext-glob-perl. +Preparing to unpack .../libtext-glob-perl_0.11-1_all.deb ... +Unpacking libtext-glob-perl (0.11-1) ... +Selecting previously unselected package libfile-find-rule-perl. +Preparing to unpack .../libfile-find-rule-perl_0.34-1_all.deb ... +Unpacking libfile-find-rule-perl (0.34-1) ... +Selecting previously unselected package usrmerge. +Preparing to unpack .../archives/usrmerge_25_all.deb ... +Unpacking usrmerge (25) ... +Setting up libtext-glob-perl (0.11-1) ... +Setting up libnumber-compare-perl (0.03-1.1) ... +Setting up libfile-find-rule-perl (0.34-1) ... +Setting up usrmerge (25) ... +The system has been successfully converted. +Processing triggers for man-db (2.9.4-2) ... +Not building database; man-db/auto-update is not 'true'. I: Building the package -I: Running cd /build/sslh-1.20/ && 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 > ../sslh_1.20-1_source.changes +hostname: Temporary failure in name resolution +I: Running cd /build/sslh-1.20/ && 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 > ../sslh_1.20-1_source.changes dpkg-buildpackage: info: source package sslh dpkg-buildpackage: info: source version 1.20-1 dpkg-buildpackage: info: source distribution unstable @@ -516,14 +583,6 @@ cc -g -O2 -fdebug-prefix-map=/build/sslh-1.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -DLIBWRAP -DENABLE_REGEX -DLIBPCRE -DLIBCONFIG -DLIBCAP -c sslh-main.c cc -g -O2 -fdebug-prefix-map=/build/sslh-1.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -DLIBWRAP -DENABLE_REGEX -DLIBPCRE -DLIBCONFIG -DLIBCAP -c probe.c cc -g -O2 -fdebug-prefix-map=/build/sslh-1.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -DLIBWRAP -DENABLE_REGEX -DLIBPCRE -DLIBCONFIG -DLIBCAP -c tls.c -common.c: In function 'check_access_rights': -common.c:635:20: warning: passing argument 1 of 'hosts_ctl' discards 'const' qualifier from pointer target type [-Wdiscarded-qualifiers] - 635 | if (!hosts_ctl(service, host, addr_str, STRING_UNKNOWN)) { - | ^~~~~~~ -In file included from common.c:49: -/usr/include/tcpd.h:131:28: note: expected 'char *' but argument is of type 'const char *' - 131 | extern int hosts_ctl(char *daemon, char *client_name, char *client_addr, - | ~~~~~~^~~~~~ sslh-main.c: In function 'setup_sni_alpn_list': sslh-main.c:292:25: warning: argument 1 range [18446744071562067969, 18446744073709551615] exceeds maximum object size 9223372036854775807 [-Walloc-size-larger-than=] 292 | sni_hostname_list = calloc(num_probes + 1, ++max_server_name_len); @@ -533,6 +592,14 @@ /usr/include/stdlib.h:542:14: note: in a call to allocation function 'calloc' declared here 542 | extern void *calloc (size_t __nmemb, size_t __size) | ^~~~~~ +common.c: In function 'check_access_rights': +common.c:635:20: warning: passing argument 1 of 'hosts_ctl' discards 'const' qualifier from pointer target type [-Wdiscarded-qualifiers] + 635 | if (!hosts_ctl(service, host, addr_str, STRING_UNKNOWN)) { + | ^~~~~~~ +In file included from common.c:49: +/usr/include/tcpd.h:131:28: note: expected 'char *' but argument is of type 'const char *' + 131 | extern int hosts_ctl(char *daemon, char *client_name, char *client_addr, + | ~~~~~~^~~~~~ cc -g -O2 -fdebug-prefix-map=/build/sslh-1.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wl,-z,relro -Wl,-z,now -o sslh-fork sslh-fork.o common.o sslh-main.o probe.o tls.o -lwrap -lpcreposix -lconfig -lcap cc -g -O2 -fdebug-prefix-map=/build/sslh-1.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wl,-z,relro -Wl,-z,now -o sslh-select sslh-select.o common.o sslh-main.o probe.o tls.o -lwrap -lpcreposix -lconfig -lcap cc -g -O2 -fdebug-prefix-map=/build/sslh-1.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wl,-z,relro -Wl,-z,now -o echosrv echosrv.o probe.o common.o tls.o -lwrap -lpcreposix -lconfig -lcap @@ -545,22 +612,22 @@ make[1]: Entering directory '/build/sslh-1.20' Makefile:66: warning: ignoring prerequisites on suffix rule definition ./t -./echosrv --listen localhost:44953 --prefix 'ssh: ' -./echosrv --listen localhost:36779 --prefix 'socks5: ' -./echosrv --listen localhost:32769 --prefix 'http: ' -./echosrv --listen localhost:40023 --prefix 'tinc: ' -./echosrv --listen localhost:40297 --prefix 'openvpn: ' -./echosrv --listen localhost:40947 --prefix 'xmpp: ' -./echosrv --listen localhost:38703 --prefix 'adb: ' -./echosrv --listen localhost:36485 --prefix 'tls:sni1;alpn1,alpn2: ' -./echosrv --listen localhost:38191 --prefix 'tls:sni2,sni3;alpn1,alpn2: ' -./echosrv --listen localhost:33689 --prefix 'tls:;alpn3: ' -./echosrv --listen localhost:35329 --prefix 'tls:sni3;: ' -./echosrv --listen localhost:40309 --prefix 'tls: ' -./echosrv --listen localhost:41175 --prefix 'anyprot: ' +./echosrv --listen localhost:32825 --prefix 'ssh: ' +./echosrv --listen localhost:45489 --prefix 'socks5: ' +./echosrv --listen localhost:38207 --prefix 'http: ' +./echosrv --listen localhost:44689 --prefix 'tinc: ' +./echosrv --listen localhost:39969 --prefix 'openvpn: ' +./echosrv --listen localhost:45091 --prefix 'xmpp: ' +./echosrv --listen localhost:45253 --prefix 'adb: ' +./echosrv --listen localhost:41081 --prefix 'tls:sni1;alpn1,alpn2: ' +./echosrv --listen localhost:34657 --prefix 'tls:sni2,sni3;alpn1,alpn2: ' +./echosrv --listen localhost:41705 --prefix 'tls:;alpn3: ' +./echosrv --listen localhost:43787 --prefix 'tls:sni3;: ' +./echosrv --listen localhost:39723 --prefix 'tls: ' +./echosrv --listen localhost:40407 --prefix 'anyprot: ' Testing sslh-select -spawned 10552 -./sslh-select -v -f -u pbuilder1 -Ftest.cfg +spawned 11851 +./sslh-select -v -f -u pbuilder2 -Ftest.cfg tls: sni_hostnames[0]: sni1 tls: alpn_protocols[0]: alpn1 tls: alpn_protocols[1]: alpn2 @@ -572,27 +639,27 @@ tls: alpn_protocols[0]: alpn3 tls: sni_hostnames[0]: sni3 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead -ssh addr: localhost:44953. libwrap service: (null) log_level: 1 family 2 2 [] [fork] -socks5 addr: localhost:36779. libwrap service: (null) log_level: 1 family 2 2 [] [] -http addr: localhost:32769. libwrap service: (null) log_level: 1 family 2 2 [] [] -tinc addr: localhost:40023. libwrap service: (null) log_level: 1 family 2 2 [] [] -openvpn addr: localhost:40297. libwrap service: (null) log_level: 1 family 2 2 [] [] -xmpp addr: localhost:40947. libwrap service: (null) log_level: 1 family 2 2 [] [] -adb addr: localhost:38703. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:36485. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:38191. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:33689. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:35329. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:40309. libwrap service: (null) log_level: 1 family 2 2 [] [] -anyprot addr: localhost:41175. libwrap service: (null) log_level: 1 family 2 2 [] [] +ssh addr: localhost:32825. libwrap service: (null) log_level: 1 family 2 2 [] [fork] +socks5 addr: localhost:45489. libwrap service: (null) log_level: 1 family 2 2 [] [] +http addr: localhost:38207. libwrap service: (null) log_level: 1 family 2 2 [] [] +tinc addr: localhost:44689. libwrap service: (null) log_level: 1 family 2 2 [] [] +openvpn addr: localhost:39969. libwrap service: (null) log_level: 1 family 2 2 [] [] +xmpp addr: localhost:45091. libwrap service: (null) log_level: 1 family 2 2 [] [] +adb addr: localhost:45253. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:41081. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:34657. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:41705. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:43787. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:39723. libwrap service: (null) log_level: 1 family 2 2 [] [] +anyprot addr: localhost:40407. libwrap service: (null) log_level: 1 family 2 2 [] [] listening on: - localhost:34375 [keepalive] + localhost:39571 [keepalive] localhost:8081 [keepalive] timeout: 10 on-timeout: ssh listening to 2 addresses sslh-select 1.20-1 started -turning into pbuilder1 +turning into pbuilder2 capabilities: = selecting... max_fd=5 num_probing=0 ***Test: Shy SSH connection @@ -624,14 +691,13 @@ timed out, connect to ssh closing fd 5 selecting... max_fd=6 num_probing=0 -connecting to localhost:44953 family 2 len 16 -ssh:connection from localhost:54374 to localhost:34375 forwarded from localhost:41060 to localhost:44953 +connecting to localhost:32825 family 2 len 16 +ssh:connection from localhost:52116 to localhost:39571 forwarded from localhost:41550 to localhost:32825 flushing deferred data to fd 4 ok 1 - Shy SSH connection ***Test: One SSL half-started then one SSH accepted fd 5 on slot 0 selecting... max_fd=6 num_probing=1 -accepted fd 6 on slot 1 processing fd0 slot 0 hexdump of incoming packet: 0x000000: 16 03 01 00 ab 01 00 00 a7 03 03 89 22 33 95 43 ............"3.C @@ -643,9 +709,11 @@ 0x000060: 00 35 00 2f 00 ff 01 00 00 46 00 0b 00 04 03 00 .5./.....F...... 0x000070: 01 02 00 0a 00 0a 00 08 00 1d 00 17 00 19 00 18 ................ 0x000080: 00 23 00 00 00 0d 00 20 00 1e 06 01 06 02 06 03 .#..... ........ -0x000090: 05 01 05 02 05 03 04 01 04 02 04 03 03 01 03 02 ................ +0x000090: 05 01 05 02 05 03 04 01 04 02 04 socket closed +03 03 01 03 02 ................ 0x0000a0: 03 03 02 01 02 02 02 03 00 16 00 00 00 17 00 00 ................ 0x0000b0: 68 65 6c 6c 6f 20 74 6c 73 20 61 6c 6f 6e 65 hello tls alone +connection closed down **** writing deferred on fd -1 probing for ssh: PROBE_NEXT probing for socks5: PROBE_NEXT @@ -659,14 +727,14 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:40309 family 2 len 16 -tls:connection from localhost:54378 to localhost:34375 forwarded from localhost:58076 to localhost:40309 -flushing deferred data to fd 7 +connecting to localhost:39723 family 2 len 16 +tls:connection from localhost:52122 to localhost:39571 forwarded from localhost:58450 to localhost:39723 +flushing deferred data to fd 6 +selecting... max_fd=7 num_probing=0 +accepted fd 7 on slot 1 selecting... max_fd=8 num_probing=1 -socket closed -connection closed down processing fd1 slot 0 -activity on fd7 +activity on fd6 selecting... max_fd=8 num_probing=1 processing fd0 slot 1 hexdump of incoming packet: @@ -692,25 +760,26 @@ selecting... max_fd=8 num_probing=1 processing fd0 slot 1 timed out, connect to ssh -closing fd 6 +closing fd 7 selecting... max_fd=8 num_probing=0 -connecting to localhost:44953 family 2 len 16 -ssh:connection from localhost:54380 to localhost:34375 forwarded from localhost:41068 to localhost:44953 +connecting to localhost:32825 family 2 len 16 +ssh:connection from localhost:52124 to localhost:39571 forwarded from localhost:41560 to localhost:32825 flushing deferred data to fd 4 ok 2 - SSH during SSL being established ok 3 - SSL connection interrupted by SSH ***Test: One SSH half-started then one SSL -accepted fd 6 on slot 1 processing fd0 slot 0 activity on fd5 closing fd 5 -closing fd 7 -selecting... max_fd=8 num_probing=1 +closing fd 6 +selecting... max_fd=8 num_probing=0 socket closed -connection closed down accepted fd 5 on slot 0 +selecting... max_fd=8 num_probing=1 +connection closed down +accepted fd 6 on slot 1 selecting... max_fd=8 num_probing=2 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 16 03 01 00 ab 01 00 00 a7 03 03 89 22 33 95 43 ............"3.C 0x000010: 7a c3 89 45 51 12 3c 28 24 1b 6a 78 bf be 95 d8 z..EQ.<($.jx.... @@ -737,15 +806,15 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:40309 family 2 len 16 -tls:connection from localhost:54388 to localhost:34375 forwarded from localhost:58084 to localhost:40309 +connecting to localhost:39723 family 2 len 16 +tls:connection from localhost:52134 to localhost:39571 forwarded from localhost:58460 to localhost:39723 flushing deferred data to fd 7 selecting... max_fd=8 num_probing=1 -processing fd1 slot 0 +processing fd1 slot 1 activity on fd7 selecting... max_fd=8 num_probing=1 ok 4 - SSL during SSH being established -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 68 65 6c 6c 6f 20 77 6f 72 6c 64 0a hello world. **** writing deferred on fd -1 @@ -767,31 +836,32 @@ Request did not begin with TLS handshake. probing for tls: PROBE_NEXT selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 timed out, connect to ssh -closing fd 6 +closing fd 5 selecting... max_fd=8 num_probing=0 -connecting to localhost:44953 family 2 len 16 -ssh:connection from localhost:54386 to localhost:34375 forwarded from localhost:41076 to localhost:44953 +connecting to localhost:32825 family 2 len 16 +ssh:connection from localhost:52132 to localhost:39571 forwarded from localhost:41568 to localhost:32825 flushing deferred data to fd 4 ok 5 - SSH connection interrupted by SSL -accepted fd 6 on slot 1 -processing fd0 slot 0 -activity on fd5 -closing fd 5 +processing fd0 slot 1 +activity on fd6 +closing fd 6 +socket closed closing fd 7 +connection closed down +selecting... max_fd=8 num_probing=0 +accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 53 53 48 2d 32 2e 30 20 74 65 73 74 65 72 SSH-2.0 tester **** writing deferred on fd -1 probing for ssh: PROBE_MATCH -closing fd 6 +closing fd 5 selecting... max_fd=8 num_probing=0 -socket closed -connection closed down -connecting to localhost:44953 family 2 len 16 -ssh:connection from localhost:54394 to localhost:34375 forwarded from localhost:41080 to localhost:44953 +connecting to localhost:32825 family 2 len 16 +ssh:connection from localhost:52140 to localhost:39571 forwarded from localhost:41572 to localhost:32825 flushing deferred data to fd 4 Received: protocol ssh data [SSH-2.0 tester] socket closed @@ -806,23 +876,24 @@ **** writing deferred on fd -1 probing for ssh: PROBE_NEXT probing for socks5: PROBE_MATCH -connecting to localhost:36779 family 2 len 16 -socks5:connection from localhost:54398 to localhost:34375 forwarded from localhost:45036 to localhost:36779 +connecting to localhost:45489 family 2 len 16 +socks5:connection from localhost:52144 to localhost:39571 forwarded from localhost:50138 to localhost:45489 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 activity on fd6 selecting... max_fd=8 num_probing=0 Received: protocol socks5 data [] -ok 8 - probe socks5 connected correctly -ok 9 - data shoveled correctly -accepted fd 7 on slot 1 processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 +selecting... max_fd=8 num_probing=0 +ok 8 - probe socks5 connected correctly +ok 9 - data shoveled correctly +accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 47 45 54 20 69 6e 64 65 78 2e 68 74 6d 6c 20 48 GET index.html H 0x000010: 54 54 50 2f 31 2e 31 TTP/1.1 @@ -830,21 +901,22 @@ probing for ssh: PROBE_NEXT probing for socks5: PROBE_NEXT probing for http: PROBE_MATCH -connecting to localhost:32769 family 2 len 16 -http:connection from localhost:54402 to localhost:34375 forwarded from localhost:60806 to localhost:32769 -flushing deferred data to fd 5 +connecting to localhost:38207 family 2 len 16 +http:connection from localhost:52148 to localhost:39571 forwarded from localhost:48022 to localhost:38207 +flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 -activity on fd5 +processing fd1 slot 0 +activity on fd6 selecting... max_fd=8 num_probing=0 Received: protocol http data [GET index.html HTTP/1.1] +processing fd0 slot 0 +activity on fd5 +closing fd 5 +closing fd 6 +selecting... max_fd=8 num_probing=0 ok 10 - probe http connected correctly ok 11 - data shoveled correctly -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 -closing fd 5 +accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 hexdump of incoming packet: @@ -854,23 +926,24 @@ probing for socks5: PROBE_NEXT probing for http: PROBE_NEXT probing for tinc: PROBE_MATCH -connecting to localhost:40023 family 2 len 16 -tinc:connection from localhost:54406 to localhost:34375 forwarded from localhost:47960 to localhost:40023 -flushing deferred data to fd 5 +connecting to localhost:44689 family 2 len 16 +tinc:connection from localhost:52152 to localhost:39571 forwarded from localhost:33430 to localhost:44689 +flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 -activity on fd5 +activity on fd6 selecting... max_fd=8 num_probing=0 Received: protocol tinc data [0 hello] -ok 12 - probe tinc connected correctly -ok 13 - data shoveled correctly -accepted fd 7 on slot 1 processing fd0 slot 0 -activity on fd6 -closing fd 6 +activity on fd5 closing fd 5 +closing fd 6 +selecting... max_fd=8 num_probing=0 +ok 12 - probe tinc connected correctly +ok 13 - data shoveled correctly +accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 00 00 .. **** writing deferred on fd -1 @@ -879,23 +952,23 @@ probing for http: PROBE_AGAIN probing for tinc: PROBE_NEXT probing for openvpn: PROBE_MATCH -connecting to localhost:40297 family 2 len 16 -openvpn:connection from localhost:54410 to localhost:34375 forwarded from localhost:57842 to localhost:40297 -flushing deferred data to fd 5 +connecting to localhost:39969 family 2 len 16 +openvpn:connection from localhost:52156 to localhost:39571 forwarded from localhost:37382 to localhost:39969 +flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 -activity on fd5 +processing fd1 slot 0 +activity on fd6 selecting... max_fd=8 num_probing=0 Received: protocol openvpn data [] ok 14 - probe openvpn connected correctly ok 15 - data shoveled correctly -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 +accepted fd 7 on slot 1 +processing fd0 slot 0 +activity on fd5 closing fd 5 +closing fd 6 selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 49 20 73 68 6f 75 6c 64 20 67 65 74 20 61 20 72 I should get a r 0x000010: 65 61 6c 20 6a 61 62 62 65 72 20 63 6f 6e 6e 65 eal jabber conne @@ -908,23 +981,23 @@ probing for tinc: PROBE_NEXT probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_MATCH -connecting to localhost:40947 family 2 len 16 -xmpp:connection from localhost:54414 to localhost:34375 forwarded from localhost:58552 to localhost:40947 +connecting to localhost:45091 family 2 len 16 +xmpp:connection from localhost:52160 to localhost:39571 forwarded from localhost:59250 to localhost:45091 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 0 +processing fd1 slot 1 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol xmpp data [I should get a real jabber connection initialisation here] ok 16 - probe xmpp connected correctly ok 17 - data shoveled correctly -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd6 -closing fd 6 +accepted fd 6 on slot 0 +processing fd0 slot 1 +activity on fd7 +closing fd 7 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 43 4e 58 4e 2e 2e 2e 2e 2e 2e 2e 2e 2e 2e 2e 2e CNXN............ 0x000010: 2e 2e 2e 2e 2e 2e 2e 2e 68 6f 73 74 3a 2e 2e 2e ........host:... @@ -936,11 +1009,11 @@ probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_AGAIN probing for adb: PROBE_MATCH -connecting to localhost:38703 family 2 len 16 -adb:connection from localhost:54418 to localhost:34375 forwarded from localhost:57710 to localhost:38703 +connecting to localhost:45253 family 2 len 16 +adb:connection from localhost:52164 to localhost:39571 forwarded from localhost:40498 to localhost:45253 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 +processing fd1 slot 0 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol adb data [CNXN....................host:...] @@ -948,13 +1021,13 @@ ok 19 - data shoveled correctly sni: sni1 alpn: alpn1 -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 +accepted fd 7 on slot 1 +processing fd0 slot 0 +activity on fd6 +closing fd 6 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -981,11 +1054,11 @@ matching [sni1] with [sni1] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:36485 family 2 len 16 -tls:connection from localhost:54422 to localhost:34375 forwarded from localhost:36048 to localhost:36485 +connecting to localhost:41081 family 2 len 16 +tls:connection from localhost:52168 to localhost:39571 forwarded from localhost:34656 to localhost:41081 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 0 +processing fd1 slot 1 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni1;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ @@ -996,13 +1069,13 @@ ok 21 - data shoveled correctly sni: sni1 alpn: alpn2 -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd6 -closing fd 6 +accepted fd 6 on slot 0 +processing fd0 slot 1 +activity on fd7 +closing fd 7 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -1030,11 +1103,11 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:36485 family 2 len 16 -tls:connection from localhost:54426 to localhost:34375 forwarded from localhost:36052 to localhost:36485 +connecting to localhost:41081 family 2 len 16 +tls:connection from localhost:52172 to localhost:39571 forwarded from localhost:34660 to localhost:41081 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 +processing fd1 slot 0 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni1;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ @@ -1045,13 +1118,13 @@ ok 23 - data shoveled correctly sni: sni2 alpn: alpn1 -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 +accepted fd 7 on slot 1 +processing fd0 slot 0 +activity on fd6 +closing fd 6 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -1080,28 +1153,29 @@ matching [sni2] with [sni2] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54430 to localhost:34375 forwarded from localhost:41366 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52176 to localhost:39571 forwarded from localhost:32884 to localhost:34657 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 0 +processing fd1 slot 1 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni2  # alpn1hello sni/alpn] +processing fd0 slot 1 +activity on fd7 +closing fd 7 +closing fd 5 +selecting... max_fd=8 num_probing=0 ok 24 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 25 - data shoveled correctly sni: sni2 alpn: alpn2 -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd6 -closing fd 6 -closing fd 5 +accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -1131,26 +1205,27 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54434 to localhost:34375 forwarded from localhost:41370 to localhost:38191 -flushing deferred data to fd 5 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52180 to localhost:39571 forwarded from localhost:32888 to localhost:34657 +flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 -activity on fd5 +processing fd1 slot 0 +activity on fd6 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni2  # alpn2hello sni/alpn] +processing fd0 slot 0 +activity on fd5 +closing fd 5 +closing fd 6 +selecting... max_fd=8 num_probing=0 ok 26 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 27 - data shoveled correctly sni: sni3 alpn: alpn1 -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 -closing fd 5 +accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 hexdump of incoming packet: @@ -1182,28 +1257,29 @@ matching [sni3] with [sni3] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54438 to localhost:34375 forwarded from localhost:41374 to localhost:38191 -flushing deferred data to fd 5 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52184 to localhost:39571 forwarded from localhost:32892 to localhost:34657 +flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 -activity on fd5 +activity on fd6 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni3  # alpn1hello sni/alpn] +processing fd0 slot 0 +activity on fd5 +closing fd 5 +closing fd 6 +selecting... max_fd=8 num_probing=0 ok 28 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 29 - data shoveled correctly sni: sni3 alpn: alpn2 -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd6 -closing fd 6 -closing fd 5 +accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -1234,12 +1310,12 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54442 to localhost:34375 forwarded from localhost:41378 to localhost:38191 -flushing deferred data to fd 5 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52188 to localhost:39571 forwarded from localhost:32896 to localhost:34657 +flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 -activity on fd5 +processing fd1 slot 0 +activity on fd6 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni3  @@ -1249,13 +1325,13 @@ ok 31 - data shoveled correctly sni: alpn: alpn3 -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 +accepted fd 7 on slot 1 +processing fd0 slot 0 +activity on fd5 closing fd 5 +closing fd 6 selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 16 03 01 00 b7 01 00 00 b3 03 03 e2 90 a2 29 03 ..............). 0x000010: 31 ad 98 44 51 54 90 5b d9 51 0e 66 b5 3f e8 8b 1..DQT.[.Q.f.?.. @@ -1288,11 +1364,11 @@ probing for tls: PROBE_NEXT matching [alpn3] with [alpn3] probing for tls: PROBE_MATCH -connecting to localhost:33689 family 2 len 16 -tls:connection from localhost:54446 to localhost:34375 forwarded from localhost:43590 to localhost:33689 +connecting to localhost:41705 family 2 len 16 +tls:connection from localhost:52192 to localhost:39571 forwarded from localhost:52786 to localhost:41705 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 0 +processing fd1 slot 1 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:;alpn3 data [·³â¢)1­˜DQT[ÙQfµ?è‹ Éä+—$ï­VÉ8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ @@ -1303,13 +1379,13 @@ ok 33 - data shoveled correctly sni: sni3 alpn: -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd6 -closing fd 6 +accepted fd 6 on slot 0 +processing fd0 slot 1 +activity on fd7 +closing fd 7 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 16 03 01 00 b8 01 00 00 b4 03 03 97 e4 e9 ad 86 ................ 0x000010: e1 21 fd c4 5b 27 0e ad 4b 55 c2 50 e4 1c 86 2f .!..['..KU.P.../ @@ -1340,11 +1416,11 @@ probing for tls: PROBE_NEXT matching [sni3] with [sni3] probing for tls: PROBE_MATCH -connecting to localhost:35329 family 2 len 16 -tls:connection from localhost:54450 to localhost:34375 forwarded from localhost:47536 to localhost:35329 +connecting to localhost:43787 family 2 len 16 +tls:connection from localhost:52196 to localhost:39571 forwarded from localhost:50772 to localhost:43787 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 +processing fd1 slot 0 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni3; data [¸´—äé­†á!ýÄ['­KUÂPä†/7%ÞèœYü©728À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ @@ -1353,13 +1429,13 @@ # hello sni] ok 34 - probe tls:sni3; connected correctly ok 35 - data shoveled correctly -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 +accepted fd 7 on slot 1 +processing fd0 slot 0 +activity on fd6 +closing fd 6 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 16 03 01 00 ab 01 00 00 a7 03 03 89 22 33 95 43 ............"3.C 0x000010: 7a c3 89 45 51 12 3c 28 24 1b 6a 78 bf be 95 d8 z..EQ.<($.jx.... @@ -1386,11 +1462,11 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:40309 family 2 len 16 -tls:connection from localhost:54454 to localhost:34375 forwarded from localhost:58150 to localhost:40309 +connecting to localhost:39723 family 2 len 16 +tls:connection from localhost:52200 to localhost:39571 forwarded from localhost:58526 to localhost:39723 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 0 +processing fd1 slot 1 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls data [«§‰"3•CzÉEQ<($jx¿¾•ØX×e÷»-² u8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ @@ -1399,13 +1475,13 @@ # hello ssl alone] ok 36 - probe tls connected correctly ok 37 - data shoveled correctly -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd6 -closing fd 6 +accepted fd 6 on slot 0 +processing fd0 slot 1 +activity on fd7 +closing fd 7 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 68 65 6c 6c 6f 20 61 6e 79 70 72 6f 74 20 74 68 hello anyprot th 0x000010: 69 73 20 6e 65 65 64 73 20 74 6f 20 62 65 20 6c is needs to be l @@ -1434,23 +1510,23 @@ probing for tls: PROBE_NEXT Request did not begin with TLS handshake. probing for tls: PROBE_NEXT -connecting to localhost:41175 family 2 len 16 -anyprot:connection from localhost:54458 to localhost:34375 forwarded from localhost:54246 to localhost:41175 +connecting to localhost:40407 family 2 len 16 +anyprot:connection from localhost:52204 to localhost:39571 forwarded from localhost:36588 to localhost:40407 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 +processing fd1 slot 0 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol anyprot data [hello anyprot this needs to be longer than xmpp and adb which expect about 50 characters, which I all have to write before the timeout!] ok 38 - probe anyprot connected correctly ok 39 - data shoveled correctly -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 +accepted fd 7 on slot 1 +processing fd0 slot 0 +activity on fd6 +closing fd 6 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 53 S **** writing deferred on fd -1 @@ -1467,7 +1543,7 @@ probing for tls: PROBE_AGAIN probing for tls: PROBE_AGAIN selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 53 S **** writing deferred on fd -1 @@ -1484,7 +1560,7 @@ probing for tls: PROBE_AGAIN probing for tls: PROBE_AGAIN selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 48 H **** writing deferred on fd -1 @@ -1501,19 +1577,17 @@ probing for tls: PROBE_AGAIN probing for tls: PROBE_AGAIN selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 2d - **** writing deferred on fd -1 probing for ssh: PROBE_MATCH -closing fd 6 +closing fd 7 selecting... max_fd=8 num_probing=0 -connecting to localhost:44953 family 2 len 16 -ssh:connection from localhost:54462 to localhost:34375 forwarded from localhost:41148 to localhost:44953 +connecting to localhost:32825 family 2 len 16 +ssh:connection from localhost:52208 to localhost:39571 forwarded from localhost:41640 to localhost:32825 flushing deferred data to fd 4 Received: protocol ssh data [SSH-2.0 tester] -socket closed -connection closed down ok 40 - probe ssh connected correctly ok 41 - data shoveled correctly accepted fd 5 on slot 0 @@ -1535,6 +1609,8 @@ probing for tls: PROBE_AGAIN probing for tls: PROBE_AGAIN selecting... max_fd=8 num_probing=1 +socket closed +connection closed down processing fd0 slot 0 hexdump of incoming packet: 0x000000: 04 . @@ -1614,8 +1690,8 @@ **** writing deferred on fd -1 probing for ssh: PROBE_NEXT probing for socks5: PROBE_MATCH -connecting to localhost:36779 family 2 len 16 -socks5:connection from localhost:54466 to localhost:34375 forwarded from localhost:45104 to localhost:36779 +connecting to localhost:45489 family 2 len 16 +socks5:connection from localhost:52212 to localhost:39571 forwarded from localhost:50206 to localhost:45489 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1638,8 +1714,8 @@ probing for ssh: PROBE_NEXT probing for socks5: PROBE_NEXT probing for http: PROBE_MATCH -connecting to localhost:32769 family 2 len 16 -http:connection from localhost:54470 to localhost:34375 forwarded from localhost:60874 to localhost:32769 +connecting to localhost:38207 family 2 len 16 +http:connection from localhost:52216 to localhost:39571 forwarded from localhost:48090 to localhost:38207 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 processing fd1 slot 1 @@ -1662,8 +1738,8 @@ probing for socks5: PROBE_NEXT probing for http: PROBE_NEXT probing for tinc: PROBE_MATCH -connecting to localhost:40023 family 2 len 16 -tinc:connection from localhost:54474 to localhost:34375 forwarded from localhost:48028 to localhost:40023 +connecting to localhost:44689 family 2 len 16 +tinc:connection from localhost:52220 to localhost:39571 forwarded from localhost:33498 to localhost:44689 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1687,8 +1763,8 @@ probing for http: PROBE_AGAIN probing for tinc: PROBE_NEXT probing for openvpn: PROBE_MATCH -connecting to localhost:40297 family 2 len 16 -openvpn:connection from localhost:54478 to localhost:34375 forwarded from localhost:57910 to localhost:40297 +connecting to localhost:39969 family 2 len 16 +openvpn:connection from localhost:52224 to localhost:39571 forwarded from localhost:37450 to localhost:39969 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 processing fd1 slot 1 @@ -1716,23 +1792,24 @@ probing for tinc: PROBE_NEXT probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_MATCH -connecting to localhost:40947 family 2 len 16 -xmpp:connection from localhost:54482 to localhost:34375 forwarded from localhost:58620 to localhost:40947 +connecting to localhost:45091 family 2 len 16 +xmpp:connection from localhost:52228 to localhost:39571 forwarded from localhost:59318 to localhost:45091 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol xmpp data [I should get a real jabber connection initialisation here] -ok 50 - probe xmpp connected correctly -ok 51 - data shoveled correctly -accepted fd 7 on slot 1 processing fd0 slot 0 activity on fd6 closing fd 6 closing fd 5 +selecting... max_fd=8 num_probing=0 +ok 50 - probe xmpp connected correctly +ok 51 - data shoveled correctly +accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 43 4e 58 4e 2e 2e 2e 2e 2e 2e 2e 2e 2e 2e 2e 2e CNXN............ 0x000010: 2e 2e 2e 2e 2e 2e 2e 2e 68 6f 73 74 3a 2e 2e 2e ........host:... @@ -1744,23 +1821,24 @@ probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_AGAIN probing for adb: PROBE_MATCH -connecting to localhost:38703 family 2 len 16 -adb:connection from localhost:54486 to localhost:34375 forwarded from localhost:57778 to localhost:38703 -flushing deferred data to fd 5 +connecting to localhost:45253 family 2 len 16 +adb:connection from localhost:52232 to localhost:39571 forwarded from localhost:40566 to localhost:45253 +flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 -activity on fd5 +processing fd1 slot 0 +activity on fd6 selecting... max_fd=8 num_probing=0 Received: protocol adb data [CNXN....................host:...] +processing fd0 slot 0 +activity on fd5 +closing fd 5 +closing fd 6 +selecting... max_fd=8 num_probing=0 ok 52 - probe adb connected correctly ok 53 - data shoveled correctly sni: sni1 alpn: alpn1 -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 -closing fd 5 +accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 hexdump of incoming packet: @@ -1789,28 +1867,29 @@ matching [sni1] with [sni1] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:36485 family 2 len 16 -tls:connection from localhost:54490 to localhost:34375 forwarded from localhost:36116 to localhost:36485 -flushing deferred data to fd 5 +connecting to localhost:41081 family 2 len 16 +tls:connection from localhost:52236 to localhost:39571 forwarded from localhost:34724 to localhost:41081 +flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 -activity on fd5 +activity on fd6 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni1;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni1  # alpn1hello sni/alpn] +processing fd0 slot 0 +activity on fd5 +closing fd 5 +closing fd 6 +selecting... max_fd=8 num_probing=0 ok 54 - probe tls:sni1;alpn1,alpn2 connected correctly ok 55 - data shoveled correctly sni: sni1 alpn: alpn2 -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd6 -closing fd 6 -closing fd 5 +accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -1838,12 +1917,12 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:36485 family 2 len 16 -tls:connection from localhost:54494 to localhost:34375 forwarded from localhost:36120 to localhost:36485 -flushing deferred data to fd 5 +connecting to localhost:41081 family 2 len 16 +tls:connection from localhost:52240 to localhost:39571 forwarded from localhost:34728 to localhost:41081 +flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 -activity on fd5 +processing fd1 slot 0 +activity on fd6 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni1;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni1  @@ -1853,13 +1932,13 @@ ok 57 - data shoveled correctly sni: sni2 alpn: alpn1 -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 +accepted fd 7 on slot 1 +processing fd0 slot 0 +activity on fd5 closing fd 5 +closing fd 6 selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -1888,11 +1967,11 @@ matching [sni2] with [sni2] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54498 to localhost:34375 forwarded from localhost:41434 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52244 to localhost:39571 forwarded from localhost:32952 to localhost:34657 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 0 +processing fd1 slot 1 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ @@ -1903,13 +1982,13 @@ ok 59 - data shoveled correctly sni: sni2 alpn: alpn2 -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd6 -closing fd 6 +accepted fd 6 on slot 0 +processing fd0 slot 1 +activity on fd7 +closing fd 7 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -1939,11 +2018,11 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54502 to localhost:34375 forwarded from localhost:41438 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52248 to localhost:39571 forwarded from localhost:32956 to localhost:34657 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 +processing fd1 slot 0 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ @@ -1954,13 +2033,13 @@ ok 61 - data shoveled correctly sni: sni3 alpn: alpn1 -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 +accepted fd 7 on slot 1 +processing fd0 slot 0 +activity on fd6 +closing fd 6 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -1990,11 +2069,11 @@ matching [sni3] with [sni3] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54506 to localhost:34375 forwarded from localhost:41442 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52252 to localhost:39571 forwarded from localhost:32960 to localhost:34657 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 0 +processing fd1 slot 1 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ @@ -2005,13 +2084,13 @@ ok 63 - data shoveled correctly sni: sni3 alpn: alpn2 -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd6 -closing fd 6 +accepted fd 6 on slot 0 +processing fd0 slot 1 +activity on fd7 +closing fd 7 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -2042,11 +2121,11 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54510 to localhost:34375 forwarded from localhost:41446 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52256 to localhost:39571 forwarded from localhost:32964 to localhost:34657 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 +processing fd1 slot 0 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ @@ -2057,13 +2136,13 @@ ok 65 - data shoveled correctly sni: alpn: alpn3 -accepted fd 6 on slot 0 -processing fd0 slot 1 -activity on fd7 -closing fd 7 +accepted fd 7 on slot 1 +processing fd0 slot 0 +activity on fd6 +closing fd 6 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 0 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 16 03 01 00 b7 01 00 00 b3 03 03 e2 90 a2 29 03 ..............). 0x000010: 31 ad 98 44 51 54 90 5b d9 51 0e 66 b5 3f e8 8b 1..DQT.[.Q.f.?.. @@ -2096,11 +2175,11 @@ probing for tls: PROBE_NEXT matching [alpn3] with [alpn3] probing for tls: PROBE_MATCH -connecting to localhost:33689 family 2 len 16 -tls:connection from localhost:54514 to localhost:34375 forwarded from localhost:43658 to localhost:33689 +connecting to localhost:41705 family 2 len 16 +tls:connection from localhost:52260 to localhost:39571 forwarded from localhost:52854 to localhost:41705 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 0 +processing fd1 slot 1 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:;alpn3 data [·³â¢)1­˜DQT[ÙQfµ?è‹ Éä+—$ï­VÉ8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ @@ -2111,13 +2190,13 @@ ok 67 - data shoveled correctly sni: sni3 alpn: -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd6 -closing fd 6 +accepted fd 6 on slot 0 +processing fd0 slot 1 +activity on fd7 +closing fd 7 closing fd 5 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 16 03 01 00 b8 01 00 00 b4 03 03 97 e4 e9 ad 86 ................ 0x000010: e1 21 fd c4 5b 27 0e ad 4b 55 c2 50 e4 1c 86 2f .!..['..KU.P.../ @@ -2148,27 +2227,26 @@ probing for tls: PROBE_NEXT matching [sni3] with [sni3] probing for tls: PROBE_MATCH -connecting to localhost:35329 family 2 len 16 -tls:connection from localhost:54518 to localhost:34375 forwarded from localhost:47604 to localhost:35329 +connecting to localhost:43787 family 2 len 16 +tls:connection from localhost:52264 to localhost:39571 forwarded from localhost:50840 to localhost:43787 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 +processing fd1 slot 0 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls:sni3; data [¸´—äé­†á!ýÄ['­KUÂPä†/7%ÞèœYü©728À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿS sni3  # hello sni] -processing fd0 slot 1 -activity on fd7 -closing fd 7 -closing fd 5 -selecting... max_fd=8 num_probing=0 ok 68 - probe tls:sni3; connected correctly ok 69 - data shoveled correctly -accepted fd 5 on slot 0 -selecting... max_fd=8 num_probing=1 +accepted fd 7 on slot 1 processing fd0 slot 0 +activity on fd6 +closing fd 6 +closing fd 5 +selecting... max_fd=8 num_probing=1 +processing fd0 slot 1 hexdump of incoming packet: 0x000000: 16 03 01 00 ab 01 00 00 a7 03 03 89 22 33 95 43 ............"3.C 0x000010: 7a c3 89 45 51 12 3c 28 24 1b 6a 78 bf be 95 d8 z..EQ.<($.jx.... @@ -2195,12 +2273,12 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:40309 family 2 len 16 -tls:connection from localhost:54522 to localhost:34375 forwarded from localhost:58218 to localhost:40309 -flushing deferred data to fd 6 +connecting to localhost:39723 family 2 len 16 +tls:connection from localhost:52268 to localhost:39571 forwarded from localhost:58594 to localhost:39723 +flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 0 -activity on fd6 +processing fd1 slot 1 +activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol tls data [«§‰"3•CzÉEQ<($jx¿¾•ØX×e÷»-² u8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿF  @@ -2208,13 +2286,13 @@ # hello ssl alone] ok 70 - probe tls connected correctly ok 71 - data shoveled correctly -accepted fd 7 on slot 1 -processing fd0 slot 0 -activity on fd5 +accepted fd 6 on slot 0 +processing fd0 slot 1 +activity on fd7 +closing fd 7 closing fd 5 -closing fd 6 selecting... max_fd=8 num_probing=1 -processing fd0 slot 1 +processing fd0 slot 0 hexdump of incoming packet: 0x000000: 68 65 6c 6c 6f 20 61 6e 79 70 72 6f 74 20 74 68 hello anyprot th 0x000010: 69 73 20 6e 65 65 64 73 20 74 6f 20 62 65 20 6c is needs to be l @@ -2243,26 +2321,26 @@ probing for tls: PROBE_NEXT Request did not begin with TLS handshake. probing for tls: PROBE_NEXT -connecting to localhost:41175 family 2 len 16 -anyprot:connection from localhost:54526 to localhost:34375 forwarded from localhost:54314 to localhost:41175 +connecting to localhost:40407 family 2 len 16 +anyprot:connection from localhost:52272 to localhost:39571 forwarded from localhost:36656 to localhost:40407 flushing deferred data to fd 5 selecting... max_fd=8 num_probing=0 -processing fd1 slot 1 +processing fd1 slot 0 activity on fd5 selecting... max_fd=8 num_probing=0 Received: protocol anyprot data [hello anyprot this needs to be longer than xmpp and adb which expect about 50 characters, which I all have to write before the timeout!] ok 72 - probe anyprot connected correctly ok 73 - data shoveled correctly -processing fd0 slot 1 -activity on fd7 -closing fd 7 +processing fd0 slot 0 +activity on fd6 +closing fd 6 closing fd 5 selecting... max_fd=8 num_probing=0 -killing 10556 +killing 11852 Testing sslh-fork -spawned 10732 -./sslh-fork -v -f -u pbuilder1 -Ftest.cfg +spawned 16159 +./sslh-fork -v -f -u pbuilder2 -Ftest.cfg tls: sni_hostnames[0]: sni1 tls: alpn_protocols[0]: alpn1 tls: alpn_protocols[1]: alpn2 @@ -2274,27 +2352,27 @@ tls: alpn_protocols[0]: alpn3 tls: sni_hostnames[0]: sni3 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead -ssh addr: localhost:44953. libwrap service: (null) log_level: 1 family 2 2 [] [fork] -socks5 addr: localhost:36779. libwrap service: (null) log_level: 1 family 2 2 [] [] -http addr: localhost:32769. libwrap service: (null) log_level: 1 family 2 2 [] [] -tinc addr: localhost:40023. libwrap service: (null) log_level: 1 family 2 2 [] [] -openvpn addr: localhost:40297. libwrap service: (null) log_level: 1 family 2 2 [] [] -xmpp addr: localhost:40947. libwrap service: (null) log_level: 1 family 2 2 [] [] -adb addr: localhost:38703. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:36485. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:38191. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:33689. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:35329. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:40309. libwrap service: (null) log_level: 1 family 2 2 [] [] -anyprot addr: localhost:41175. libwrap service: (null) log_level: 1 family 2 2 [] [] +ssh addr: localhost:32825. libwrap service: (null) log_level: 1 family 2 2 [] [fork] +socks5 addr: localhost:45489. libwrap service: (null) log_level: 1 family 2 2 [] [] +http addr: localhost:38207. libwrap service: (null) log_level: 1 family 2 2 [] [] +tinc addr: localhost:44689. libwrap service: (null) log_level: 1 family 2 2 [] [] +openvpn addr: localhost:39969. libwrap service: (null) log_level: 1 family 2 2 [] [] +xmpp addr: localhost:45091. libwrap service: (null) log_level: 1 family 2 2 [] [] +adb addr: localhost:45253. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:41081. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:34657. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:41705. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:43787. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:39723. libwrap service: (null) log_level: 1 family 2 2 [] [] +anyprot addr: localhost:40407. libwrap service: (null) log_level: 1 family 2 2 [] [] listening on: - localhost:34375 [keepalive] + localhost:39571 [keepalive] localhost:8081 [keepalive] timeout: 10 on-timeout: ssh listening to 2 addresses sslh-fork 1.20-1 started -turning into pbuilder1 +turning into pbuilder2 capabilities: = ***Test: Shy SSH connection accepted fd 5 @@ -2319,8 +2397,8 @@ Request did not begin with TLS handshake. probing for tls: PROBE_NEXT timed out, connect to ssh -connecting to localhost:44953 family 2 len 16 -ssh:connection from localhost:54530 to localhost:34375 forwarded from localhost:41216 to localhost:44953 +connecting to localhost:32825 family 2 len 16 +ssh:connection from localhost:52278 to localhost:39571 forwarded from localhost:41710 to localhost:32825 flushing deferred data to fd 3 ok 74 - Shy SSH connection server socket closed @@ -2354,8 +2432,8 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:40309 family 2 len 16 -tls:connection from localhost:54534 to localhost:34375 forwarded from localhost:58232 to localhost:40309 +connecting to localhost:39723 family 2 len 16 +tls:connection from localhost:52282 to localhost:39571 forwarded from localhost:58610 to localhost:39723 flushing deferred data to fd 3 hexdump of incoming packet: 0x000000: 68 65 6c 6c 6f 20 77 6f 72 6c 64 0a hello world. @@ -2378,16 +2456,16 @@ Request did not begin with TLS handshake. probing for tls: PROBE_NEXT timed out, connect to ssh -connecting to localhost:44953 family 2 len 16 -ssh:connection from localhost:54536 to localhost:34375 forwarded from localhost:41224 to localhost:44953 +connecting to localhost:32825 family 2 len 16 +ssh:connection from localhost:52284 to localhost:39571 forwarded from localhost:41718 to localhost:32825 flushing deferred data to fd 3 ok 75 - SSH during SSL being established ok 76 - SSL connection interrupted by SSH server socket closed -connection closed down ***Test: One SSH half-started then one SSL server socket closed connection closed down +connection closed down accepted fd 5 accepted fd 5 hexdump of incoming packet: @@ -2416,8 +2494,8 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:40309 family 2 len 16 -tls:connection from localhost:54544 to localhost:34375 forwarded from localhost:58240 to localhost:40309 +connecting to localhost:39723 family 2 len 16 +tls:connection from localhost:52294 to localhost:39571 forwarded from localhost:58620 to localhost:39723 flushing deferred data to fd 3 ok 77 - SSL during SSH being established hexdump of incoming packet: @@ -2441,21 +2519,21 @@ Request did not begin with TLS handshake. probing for tls: PROBE_NEXT timed out, connect to ssh -connecting to localhost:44953 family 2 len 16 -ssh:connection from localhost:54542 to localhost:34375 forwarded from localhost:41232 to localhost:44953 +connecting to localhost:32825 family 2 len 16 +ssh:connection from localhost:52290 to localhost:39571 forwarded from localhost:41728 to localhost:32825 flushing deferred data to fd 3 ok 78 - SSH connection interrupted by SSL server socket closed connection closed down accepted fd 5 server socket closed -connection closed down hexdump of incoming packet: +connection closed down 0x000000: 53 53 48 2d 32 2e 30 20 74 65 73 74 65 72 SSH-2.0 tester **** writing deferred on fd -1 probing for ssh: PROBE_MATCH -connecting to localhost:44953 family 2 len 16 -ssh:connection from localhost:54550 to localhost:34375 forwarded from localhost:41236 to localhost:44953 +connecting to localhost:32825 family 2 len 16 +ssh:connection from localhost:52300 to localhost:39571 forwarded from localhost:41732 to localhost:32825 flushing deferred data to fd 3 Received: protocol ssh data [SSH-2.0 tester] server socket closed @@ -2468,15 +2546,15 @@ **** writing deferred on fd -1 probing for ssh: PROBE_NEXT probing for socks5: PROBE_MATCH -connecting to localhost:36779 family 2 len 16 -socks5:connection from localhost:54554 to localhost:34375 forwarded from localhost:45192 to localhost:36779 +connecting to localhost:45489 family 2 len 16 +socks5:connection from localhost:52304 to localhost:39571 forwarded from localhost:50298 to localhost:45489 flushing deferred data to fd 3 Received: protocol socks5 data [] ok 81 - probe socks5 connected correctly ok 82 - data shoveled correctly +accepted fd 5 server socket closed connection closed down -accepted fd 5 hexdump of incoming packet: 0x000000: 47 45 54 20 69 6e 64 65 78 2e 68 74 6d 6c 20 48 GET index.html H 0x000010: 54 54 50 2f 31 2e 31 TTP/1.1 @@ -2484,8 +2562,8 @@ probing for ssh: PROBE_NEXT probing for socks5: PROBE_NEXT probing for http: PROBE_MATCH -connecting to localhost:32769 family 2 len 16 -http:connection from localhost:54558 to localhost:34375 forwarded from localhost:60962 to localhost:32769 +connecting to localhost:38207 family 2 len 16 +http:connection from localhost:52308 to localhost:39571 forwarded from localhost:48182 to localhost:38207 flushing deferred data to fd 3 Received: protocol http data [GET index.html HTTP/1.1] server socket closed @@ -2500,8 +2578,8 @@ probing for socks5: PROBE_NEXT probing for http: PROBE_NEXT probing for tinc: PROBE_MATCH -connecting to localhost:40023 family 2 len 16 -tinc:connection from localhost:54562 to localhost:34375 forwarded from localhost:48116 to localhost:40023 +connecting to localhost:44689 family 2 len 16 +tinc:connection from localhost:52312 to localhost:39571 forwarded from localhost:33590 to localhost:44689 flushing deferred data to fd 3 Received: protocol tinc data [0 hello] server socket closed @@ -2517,8 +2595,8 @@ probing for http: PROBE_AGAIN probing for tinc: PROBE_NEXT probing for openvpn: PROBE_MATCH -connecting to localhost:40297 family 2 len 16 -openvpn:connection from localhost:54566 to localhost:34375 forwarded from localhost:57998 to localhost:40297 +connecting to localhost:39969 family 2 len 16 +openvpn:connection from localhost:52316 to localhost:39571 forwarded from localhost:37542 to localhost:39969 flushing deferred data to fd 3 Received: protocol openvpn data [] ok 87 - probe openvpn connected correctly @@ -2538,8 +2616,8 @@ probing for tinc: PROBE_NEXT probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_MATCH -connecting to localhost:40947 family 2 len 16 -xmpp:connection from localhost:54570 to localhost:34375 forwarded from localhost:58708 to localhost:40947 +connecting to localhost:45091 family 2 len 16 +xmpp:connection from localhost:52320 to localhost:39571 forwarded from localhost:59410 to localhost:45091 flushing deferred data to fd 3 Received: protocol xmpp data [I should get a real jabber connection initialisation here] server socket closed @@ -2558,8 +2636,8 @@ probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_AGAIN probing for adb: PROBE_MATCH -connecting to localhost:38703 family 2 len 16 -adb:connection from localhost:54574 to localhost:34375 forwarded from localhost:57866 to localhost:38703 +connecting to localhost:45253 family 2 len 16 +adb:connection from localhost:52324 to localhost:39571 forwarded from localhost:40658 to localhost:45253 flushing deferred data to fd 3 Received: protocol adb data [CNXN....................host:...] server socket closed @@ -2595,8 +2673,8 @@ matching [sni1] with [sni1] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:36485 family 2 len 16 -tls:connection from localhost:54578 to localhost:34375 forwarded from localhost:36204 to localhost:36485 +connecting to localhost:41081 family 2 len 16 +tls:connection from localhost:52328 to localhost:39571 forwarded from localhost:34816 to localhost:41081 flushing deferred data to fd 3 Received: protocol tls:sni1;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni1  @@ -2636,20 +2714,20 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:36485 family 2 len 16 -tls:connection from localhost:54582 to localhost:34375 forwarded from localhost:36208 to localhost:36485 +connecting to localhost:41081 family 2 len 16 +tls:connection from localhost:52332 to localhost:39571 forwarded from localhost:34820 to localhost:41081 flushing deferred data to fd 3 Received: protocol tls:sni1;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni1  # alpn2hello sni/alpn] +server socket closed +connection closed down ok 95 - probe tls:sni1;alpn1,alpn2 connected correctly ok 96 - data shoveled correctly sni: sni2 alpn: alpn1 -server socket closed accepted fd 5 -connection closed down hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -2678,19 +2756,19 @@ matching [sni2] with [sni2] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54586 to localhost:34375 forwarded from localhost:41522 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52336 to localhost:39571 forwarded from localhost:33044 to localhost:34657 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni2  # alpn1hello sni/alpn] -server socket closed -connection closed down ok 97 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 98 - data shoveled correctly sni: sni2 alpn: alpn2 +server socket closed +connection closed down accepted fd 5 hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ @@ -2721,8 +2799,8 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54590 to localhost:34375 forwarded from localhost:41526 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52340 to localhost:39571 forwarded from localhost:33048 to localhost:34657 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni2  @@ -2764,8 +2842,8 @@ matching [sni3] with [sni3] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54594 to localhost:34375 forwarded from localhost:41530 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52344 to localhost:39571 forwarded from localhost:33052 to localhost:34657 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni3  @@ -2808,21 +2886,21 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54598 to localhost:34375 forwarded from localhost:41534 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52348 to localhost:39571 forwarded from localhost:33056 to localhost:34657 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni3  # alpn2hello sni/alpn] -server socket closed -connection closed down ok 103 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 104 - data shoveled correctly sni: alpn: alpn3 accepted fd 5 +server socket closed hexdump of incoming packet: +connection closed down 0x000000: 16 03 01 00 b7 01 00 00 b3 03 03 e2 90 a2 29 03 ..............). 0x000010: 31 ad 98 44 51 54 90 5b d9 51 0e 66 b5 3f e8 8b 1..DQT.[.Q.f.?.. 0x000020: 09 c9 e4 2b 97 24 ef ad 56 06 c9 00 00 38 c0 2c ...+.$..V....8., @@ -2854,8 +2932,8 @@ probing for tls: PROBE_NEXT matching [alpn3] with [alpn3] probing for tls: PROBE_MATCH -connecting to localhost:33689 family 2 len 16 -tls:connection from localhost:54602 to localhost:34375 forwarded from localhost:43746 to localhost:33689 +connecting to localhost:41705 family 2 len 16 +tls:connection from localhost:52352 to localhost:39571 forwarded from localhost:52946 to localhost:41705 flushing deferred data to fd 3 Received: protocol tls:;alpn3 data [·³â¢)1­˜DQT[ÙQfµ?è‹ Éä+—$ï­VÉ8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿR  @@ -2898,17 +2976,17 @@ probing for tls: PROBE_NEXT matching [sni3] with [sni3] probing for tls: PROBE_MATCH -connecting to localhost:35329 family 2 len 16 -tls:connection from localhost:54606 to localhost:34375 forwarded from localhost:47692 to localhost:35329 +connecting to localhost:43787 family 2 len 16 +tls:connection from localhost:52356 to localhost:39571 forwarded from localhost:50932 to localhost:43787 flushing deferred data to fd 3 Received: protocol tls:sni3; data [¸´—äé­†á!ýÄ['­KUÂPä†/7%ÞèœYü©728À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿS sni3  # hello sni] -server socket closed -connection closed down ok 107 - probe tls:sni3; connected correctly ok 108 - data shoveled correctly +server socket closed +connection closed down accepted fd 5 hexdump of incoming packet: 0x000000: 16 03 01 00 ab 01 00 00 a7 03 03 89 22 33 95 43 ............"3.C @@ -2936,8 +3014,8 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:40309 family 2 len 16 -tls:connection from localhost:54610 to localhost:34375 forwarded from localhost:58306 to localhost:40309 +connecting to localhost:39723 family 2 len 16 +tls:connection from localhost:52360 to localhost:39571 forwarded from localhost:58686 to localhost:39723 flushing deferred data to fd 3 Received: protocol tls data [«§‰"3•CzÉEQ<($jx¿¾•ØX×e÷»-² u8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿF  @@ -2976,17 +3054,17 @@ probing for tls: PROBE_NEXT Request did not begin with TLS handshake. probing for tls: PROBE_NEXT -connecting to localhost:41175 family 2 len 16 -anyprot:connection from localhost:54614 to localhost:34375 forwarded from localhost:54402 to localhost:41175 +connecting to localhost:40407 family 2 len 16 +anyprot:connection from localhost:52364 to localhost:39571 forwarded from localhost:36748 to localhost:40407 flushing deferred data to fd 3 Received: protocol anyprot data [hello anyprot this needs to be longer than xmpp and adb which expect about 50 characters, which I all have to write before the timeout!] ok 111 - probe anyprot connected correctly ok 112 - data shoveled correctly accepted fd 5 server socket closed +connection closed down hexdump of incoming packet: -0x000000: 53 connection closed down - S +0x000000: 53 S **** writing deferred on fd -1 probing for ssh: PROBE_AGAIN probing for socks5: PROBE_AGAIN @@ -3034,17 +3112,17 @@ 0x000000: 2d - **** writing deferred on fd -1 probing for ssh: PROBE_MATCH -connecting to localhost:44953 family 2 len 16 -ssh:connection from localhost:54618 to localhost:34375 forwarded from localhost:41304 to localhost:44953 +connecting to localhost:32825 family 2 len 16 +ssh:connection from localhost:52368 to localhost:39571 forwarded from localhost:41800 to localhost:32825 flushing deferred data to fd 3 Received: protocol ssh data [SSH-2.0 tester] -server socket closed -connection closed down ok 113 - probe ssh connected correctly ok 114 - data shoveled correctly accepted fd 5 +server socket closed hexdump of incoming packet: -0x000000: 05 . +0x000000: connection closed down +05 . **** writing deferred on fd -1 probing for ssh: PROBE_AGAIN probing for socks5: PROBE_AGAIN @@ -3128,12 +3206,10 @@ **** writing deferred on fd -1 probing for ssh: PROBE_NEXT probing for socks5: PROBE_MATCH -connecting to localhost:36779 family 2 len 16 -socks5:connection from localhost:54622 to localhost:34375 forwarded from localhost:45260 to localhost:36779 +connecting to localhost:45489 family 2 len 16 +socks5:connection from localhost:52372 to localhost:39571 forwarded from localhost:50366 to localhost:45489 flushing deferred data to fd 3 Received: protocol socks5 data [] -server socket closed -connection closed down ok 115 - probe socks5 connected correctly ok 116 - data shoveled correctly accepted fd 5 @@ -3144,14 +3220,16 @@ probing for ssh: PROBE_NEXT probing for socks5: PROBE_NEXT probing for http: PROBE_MATCH -connecting to localhost:32769 family 2 len 16 -http:connection from localhost:54626 to localhost:34375 forwarded from localhost:32798 to localhost:32769 +connecting to localhost:38207 family 2 len 16 +server socket closed +connection closed down +http:connection from localhost:52376 to localhost:39571 forwarded from localhost:48250 to localhost:38207 flushing deferred data to fd 3 Received: protocol http data [GET index.html HTTP/1.1] -ok 117 - probe http connected correctly -ok 118 - data shoveled correctly server socket closed connection closed down +ok 117 - probe http connected correctly +ok 118 - data shoveled correctly accepted fd 5 hexdump of incoming packet: 0x000000: 30 20 68 65 6c 6c 6f 0 hello @@ -3160,14 +3238,14 @@ probing for socks5: PROBE_NEXT probing for http: PROBE_NEXT probing for tinc: PROBE_MATCH -connecting to localhost:40023 family 2 len 16 -tinc:connection from localhost:54630 to localhost:34375 forwarded from localhost:48184 to localhost:40023 +connecting to localhost:44689 family 2 len 16 +tinc:connection from localhost:52380 to localhost:39571 forwarded from localhost:33658 to localhost:44689 flushing deferred data to fd 3 Received: protocol tinc data [0 hello] -ok 119 - probe tinc connected correctly -ok 120 - data shoveled correctly server socket closed connection closed down +ok 119 - probe tinc connected correctly +ok 120 - data shoveled correctly accepted fd 5 hexdump of incoming packet: 0x000000: 00 00 .. @@ -3177,15 +3255,15 @@ probing for http: PROBE_AGAIN probing for tinc: PROBE_NEXT probing for openvpn: PROBE_MATCH -connecting to localhost:40297 family 2 len 16 -openvpn:connection from localhost:54634 to localhost:34375 forwarded from localhost:58066 to localhost:40297 +connecting to localhost:39969 family 2 len 16 +openvpn:connection from localhost:52384 to localhost:39571 forwarded from localhost:37610 to localhost:39969 flushing deferred data to fd 3 Received: protocol openvpn data [] -server socket closed -connection closed down ok 121 - probe openvpn connected correctly ok 122 - data shoveled correctly +server socket closed accepted fd 5 +connection closed down hexdump of incoming packet: 0x000000: 49 20 73 68 6f 75 6c 64 20 67 65 74 20 61 20 72 I should get a r 0x000010: 65 61 6c 20 6a 61 62 62 65 72 20 63 6f 6e 6e 65 eal jabber conne @@ -3198,8 +3276,8 @@ probing for tinc: PROBE_NEXT probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_MATCH -connecting to localhost:40947 family 2 len 16 -xmpp:connection from localhost:54638 to localhost:34375 forwarded from localhost:58776 to localhost:40947 +connecting to localhost:45091 family 2 len 16 +xmpp:connection from localhost:52388 to localhost:39571 forwarded from localhost:59478 to localhost:45091 flushing deferred data to fd 3 Received: protocol xmpp data [I should get a real jabber connection initialisation here] ok 123 - probe xmpp connected correctly @@ -3218,8 +3296,8 @@ probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_AGAIN probing for adb: PROBE_MATCH -connecting to localhost:38703 family 2 len 16 -adb:connection from localhost:54642 to localhost:34375 forwarded from localhost:57934 to localhost:38703 +connecting to localhost:45253 family 2 len 16 +adb:connection from localhost:52392 to localhost:39571 forwarded from localhost:40726 to localhost:45253 flushing deferred data to fd 3 Received: protocol adb data [CNXN....................host:...] server socket closed @@ -3255,16 +3333,16 @@ matching [sni1] with [sni1] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:36485 family 2 len 16 -tls:connection from localhost:54646 to localhost:34375 forwarded from localhost:36272 to localhost:36485 +connecting to localhost:41081 family 2 len 16 +tls:connection from localhost:52396 to localhost:39571 forwarded from localhost:34884 to localhost:41081 flushing deferred data to fd 3 Received: protocol tls:sni1;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni1  # alpn1hello sni/alpn] +ok 127 - probe tls:sni1;alpn1,alpn2 connected correctly server socket closed connection closed down -ok 127 - probe tls:sni1;alpn1,alpn2 connected correctly ok 128 - data shoveled correctly sni: sni1 alpn: alpn2 @@ -3296,21 +3374,21 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:36485 family 2 len 16 -tls:connection from localhost:54650 to localhost:34375 forwarded from localhost:36276 to localhost:36485 +connecting to localhost:41081 family 2 len 16 +tls:connection from localhost:52400 to localhost:39571 forwarded from localhost:34888 to localhost:41081 flushing deferred data to fd 3 Received: protocol tls:sni1;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni1  # alpn2hello sni/alpn] -server socket closed -connection closed down ok 129 - probe tls:sni1;alpn1,alpn2 connected correctly ok 130 - data shoveled correctly sni: sni2 alpn: alpn1 accepted fd 5 +server socket closed hexdump of incoming packet: +connection closed down 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. 0x000020: d1 3c 5d 05 19 cb 27 0d 7c 2c 89 00 00 38 c0 2c .<]...'.|,...8., @@ -3338,20 +3416,20 @@ matching [sni2] with [sni2] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54654 to localhost:34375 forwarded from localhost:41590 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52404 to localhost:39571 forwarded from localhost:33112 to localhost:34657 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni2  # alpn1hello sni/alpn] +server socket closed +connection closed down ok 131 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 132 - data shoveled correctly sni: sni2 alpn: alpn2 accepted fd 5 -server socket closed -connection closed down hexdump of incoming packet: 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. @@ -3381,8 +3459,8 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54658 to localhost:34375 forwarded from localhost:41594 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52408 to localhost:39571 forwarded from localhost:33116 to localhost:34657 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni2  @@ -3394,8 +3472,8 @@ alpn: alpn1 accepted fd 5 server socket closed -connection closed down hexdump of incoming packet: +connection closed down 0x000000: 16 03 01 00 c4 01 00 00 c0 03 03 03 19 01 00 40 ...............@ 0x000010: 14 13 cc 1b 94 ad 20 5d 13 1a 8d d2 65 23 70 de ...... ]....e#p. 0x000020: d1 3c 5d 05 19 cb 27 0d 7c 2c 89 00 00 38 c0 2c .<]...'.|,...8., @@ -3424,13 +3502,15 @@ matching [sni3] with [sni3] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54662 to localhost:34375 forwarded from localhost:41598 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52412 to localhost:39571 forwarded from localhost:33120 to localhost:34657 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni3  # alpn1hello sni/alpn] +server socket closed +connection closed down ok 135 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 136 - data shoveled correctly sni: sni3 @@ -3444,11 +3524,9 @@ 0x000040: c0 24 c0 28 00 6b c0 23 c0 27 00 67 c0 0a c0 14 .$.(.k.#.'.g.... 0x000050: 00 39 c0 09 c0 13 00 33 00 9d 00 9c 00 3d 00 3c .9.....3.....=.< 0x000060: 00 35 00 2f 00 ff 01 00 00 5f 00 00 00 09 00 07 .5./....._...... -0x000070: 00 00 server socket closed -04 73 6e 69 33 00 0b 00 04 03 00 01 02 00 ...sni3......... +0x000070: 00 00 04 73 6e 69 33 00 0b 00 04 03 00 01 02 00 ...sni3......... 0x000080: 0a 00 0a 00 08 00 1d 00 17 00 19 00 18 00 23 00 ..............#. -0x000090: 00 00 0d 00 20 00 1e 06 01 06 02 06 03 05 01 05 .... ..........connection closed down -. +0x000090: 00 00 0d 00 20 00 1e 06 01 06 02 06 03 05 01 05 .... ........... 0x0000a0: 02 05 03 04 01 04 02 04 03 03 01 03 02 03 03 02 ................ 0x0000b0: 01 02 02 02 03 00 10 00 08 00 06 05 61 6c 70 6e ............alpn 0x0000c0: 32 00 16 00 00 00 17 00 00 68 65 6c 6c 6f 20 73 2........hello s @@ -3468,8 +3546,8 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:38191 family 2 len 16 -tls:connection from localhost:54666 to localhost:34375 forwarded from localhost:41602 to localhost:38191 +connecting to localhost:34657 family 2 len 16 +tls:connection from localhost:52416 to localhost:39571 forwarded from localhost:33124 to localhost:34657 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [ÄÀ@Ì”­ ]Òe#pÞÑ<]Ë' |,‰8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿ_ sni3  @@ -3514,8 +3592,8 @@ probing for tls: PROBE_NEXT matching [alpn3] with [alpn3] probing for tls: PROBE_MATCH -connecting to localhost:33689 family 2 len 16 -tls:connection from localhost:54670 to localhost:34375 forwarded from localhost:43814 to localhost:33689 +connecting to localhost:41705 family 2 len 16 +tls:connection from localhost:52420 to localhost:39571 forwarded from localhost:53014 to localhost:41705 flushing deferred data to fd 3 Received: protocol tls:;alpn3 data [·³â¢)1­˜DQT[ÙQfµ?è‹ Éä+—$ï­VÉ8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿR  @@ -3558,8 +3636,8 @@ probing for tls: PROBE_NEXT matching [sni3] with [sni3] probing for tls: PROBE_MATCH -connecting to localhost:35329 family 2 len 16 -tls:connection from localhost:54674 to localhost:34375 forwarded from localhost:47760 to localhost:35329 +connecting to localhost:43787 family 2 len 16 +tls:connection from localhost:52424 to localhost:39571 forwarded from localhost:51000 to localhost:43787 flushing deferred data to fd 3 Received: protocol tls:sni3; data [¸´—äé­†á!ýÄ['­KUÂPä†/7%ÞèœYü©728À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿS sni3  @@ -3596,8 +3674,8 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:40309 family 2 len 16 -tls:connection from localhost:54678 to localhost:34375 forwarded from localhost:58374 to localhost:40309 +connecting to localhost:39723 family 2 len 16 +tls:connection from localhost:52428 to localhost:39571 forwarded from localhost:58754 to localhost:39723 flushing deferred data to fd 3 Received: protocol tls data [«§‰"3•CzÉEQ<($jx¿¾•ØX×e÷»-² u8À,À0ŸÌ©Ì¨ÌªÀ+À/žÀ$À(kÀ#À'gÀ À9À À3œ=<5/ÿF  @@ -3636,28 +3714,28 @@ probing for tls: PROBE_NEXT Request did not begin with TLS handshake. probing for tls: PROBE_NEXT -connecting to localhost:41175 family 2 len 16 -anyprot:connection from localhost:54682 to localhost:34375 forwarded from localhost:54470 to localhost:41175 +connecting to localhost:40407 family 2 len 16 +anyprot:connection from localhost:52432 to localhost:39571 forwarded from localhost:36816 to localhost:40407 flushing deferred data to fd 3 Received: protocol anyprot data [hello anyprot this needs to be longer than xmpp and adb which expect about 50 characters, which I all have to write before the timeout!] -server socket closed -connection closed down ok 145 - probe anyprot connected correctly ok 146 - data shoveled correctly -killing 10733 +server socket closed +connection closed down +killing 16160 ***Test: Connecting to non-existant server -spawned 10897 +spawned 17864 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead -ssh addr: localhost:43709. libwrap service: sshd log_level: 1 family 2 2 [] [fork] -tls addr: localhost:43709. libwrap service: (null) log_level: 1 family 2 2 [] [] +ssh addr: localhost:38115. libwrap service: sshd log_level: 1 family 2 2 [] [fork] +tls addr: localhost:38115. libwrap service: (null) log_level: 1 family 2 2 [] [] listening on: - localhost:34375 [] + localhost:39571 [] timeout: 2 on-timeout: ssh listening to 1 addresses sslh-select 1.20-1 started -turning into pbuilder1 +turning into pbuilder2 capabilities: = selecting... max_fd=4 num_probing=0 accepted fd 4 on slot 0 @@ -3669,45 +3747,45 @@ probing for ssh: PROBE_NEXT Request did not begin with TLS handshake. probing for tls: PROBE_NEXT -connecting to localhost:43709 family 2 len 16 +connecting to localhost:38115 family 2 len 16 forward to tls failed:connect: Connection refused closing fd 4 selecting... max_fd=5 num_probing=0 ***Test: No hostname in address -spawned 10909 +spawned 18148 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead -34375: names must be fully specified as hostname:port +39571: names must be fully specified as hostname:port exited with 1 ok 147 - Exit status on illegal option ***Test: Changing to non-existant username -spawned 10910 +spawned 18149 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead -ssh addr: localhost:44953. libwrap service: sshd log_level: 1 family 2 2 [] [fork] -tls addr: localhost:35329. libwrap service: (null) log_level: 1 family 2 2 [] [] +ssh addr: localhost:32825. libwrap service: sshd log_level: 1 family 2 2 [] [fork] +tls addr: localhost:43787. libwrap service: (null) log_level: 1 family 2 2 [] [] listening on: - localhost:34375 [] + localhost:39571 [] timeout: 2 on-timeout: ssh listening to 1 addresses sslh-select 1.20-1 started -pbuilder1_doesnt_exist: not found +pbuilder2_doesnt_exist: not found exited with 2 ok 148 - Exit status on non-existant username ***Test: Can't open PID file -spawned 10911 +spawned 18150 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead -ssh addr: localhost:44953. libwrap service: sshd log_level: 1 family 2 2 [] [fork] -tls addr: localhost:35329. libwrap service: (null) log_level: 1 family 2 2 [] [] +ssh addr: localhost:32825. libwrap service: sshd log_level: 1 family 2 2 [] [fork] +tls addr: localhost:43787. libwrap service: (null) log_level: 1 family 2 2 [] [] listening on: - localhost:34375 [] + localhost:39571 [] timeout: 2 on-timeout: ssh listening to 1 addresses -/dont_exist//tmp/hgnlwqRJ1u/sslh.pid: No such file or directory +/dont_exist//tmp/6mdCNd49oG/sslh.pid: No such file or directory exited with 3 ok 149 - Exit status if can't open PID file ***Test: Can't resolve address -spawned 10912 +spawned 18151 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead Temporary failure in name resolution `blahblah.dontexist:9000' Temporary failure in name resolution `blahblah.dontexist' @@ -3715,19 +3793,6 @@ ok 150 - Exit status if can't resolve address geninfo: WARNING: no .gcda files found in . - skipping! genhtml: ERROR: no valid records found in tracefile sslh_cov.info -Terminated -Terminated -Terminated -Terminated -Terminated -Terminated -Terminated -Terminated -Terminated -Terminated -Terminated -Terminated -Terminated 1..150 make[1]: Leaving directory '/build/sslh-1.20' create-stamp debian/debhelper-build-stamp @@ -3788,12 +3853,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: including full source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/32569/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/32569/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/7967 and its subdirectories -I: Current time: Sat Aug 14 10:39:18 -12 2021 -I: pbuilder-time-stamp: 1628980758 +I: removing directory /srv/workspace/pbuilder/32569 and its subdirectories +I: Current time: Sat Sep 17 19:04:46 +14 2022 +I: pbuilder-time-stamp: 1663391086