Diff of the two buildlogs: -- --- b1/build.log 2024-07-22 18:03:26.674250669 +0000 +++ b2/build.log 2024-07-22 18:07:28.599986485 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Sun Aug 24 12:24:28 -12 2025 -I: pbuilder-time-stamp: 1756081468 +I: Current time: Tue Jul 23 08:03:29 +14 2024 +I: pbuilder-time-stamp: 1721671409 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bullseye-reproducible-base.tgz] I: copying local configuration @@ -17,8 +17,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.SGp_aARx/trustedkeys.kbx': General error -gpgv: Signature made Fri Sep 20 17:57:42 2019 -12 +gpgv: keyblock resource '/tmp/dpkg-verify-sig.GBCjmAYv/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 @@ -33,135 +33,166 @@ dpkg-source: info: applying t_no_libconfig I: using fakeroot in build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/2631684/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/2701157/tmp/hooks/D01_modify_environment starting +debug: Running on ionos11-amd64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Jul 23 08:03 /bin/sh -> /bin/bash +I: Setting pbuilder2's login shell to /bin/bash +I: Setting pbuilder2's GECOS to second user,second room,second work-phone,second home-phone,second other +I: user script /srv/workspace/pbuilder/2701157/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/2701157/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='amd64' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all,-fixfilepath parallel=42 ' - DISTRIBUTION='bullseye' - HOME='/root' - HOST_ARCH='amd64' + 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]="x86_64-pc-linux-gnu") + BASH_VERSION='5.1.4(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=amd64 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all,-fixfilepath parallel=20 ' + DIRSTACK=() + DISTRIBUTION=bullseye + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=x86_64 + HOST_ARCH=amd64 IFS=' ' - INVOCATION_ID='a7d94cccd29c497cabee858aba359994' - 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='2631684' - PS1='# ' - PS2='> ' + INVOCATION_ID=40fd3de5801048dc93ab3c6bb61681a1 + LANG=C + LANGUAGE=et_EE:et + LC_ALL=C + MACHTYPE=x86_64-pc-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=2701157 PS4='+ ' - PWD='/' - SHELL='/bin/bash' - SHLVL='2' - SUDO_COMMAND='/usr/bin/timeout -k 18.1h 18h /usr/bin/ionice -c 3 /usr/bin/nice /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.8Qwyk64q/pbuilderrc_Reoy --distribution bullseye --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.8Qwyk64q/b1 --logfile b1/build.log sslh_1.20-1.dsc' - SUDO_GID='111' - SUDO_UID='106' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://213.165.73.152:3128' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.8Qwyk64q/pbuilderrc_fDNt --distribution bullseye --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.8Qwyk64q/b2 --logfile b2/build.log sslh_1.20-1.dsc' + SUDO_GID=111 + SUDO_UID=106 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://46.16.76.132:3128 I: uname -a - Linux ionos15-amd64 6.9.7+bpo-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.9.7-1~bpo12+1 (2024-07-03) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-23-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.99-1 (2024-07-15) x86_64 GNU/Linux I: ls -l /bin total 5476 - -rwxr-xr-x 1 root root 1234376 Mar 27 2022 bash - -rwxr-xr-x 3 root root 38984 Jul 20 2020 bunzip2 - -rwxr-xr-x 3 root root 38984 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 38984 Jul 20 2020 bzip2 - -rwxr-xr-x 1 root root 18424 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 43936 Sep 23 2020 cat - -rwxr-xr-x 1 root root 72672 Sep 23 2020 chgrp - -rwxr-xr-x 1 root root 64448 Sep 23 2020 chmod - -rwxr-xr-x 1 root root 72672 Sep 23 2020 chown - -rwxr-xr-x 1 root root 151168 Sep 23 2020 cp - -rwxr-xr-x 1 root root 125560 Dec 10 2020 dash - -rwxr-xr-x 1 root root 113664 Sep 23 2020 date - -rwxr-xr-x 1 root root 80968 Sep 23 2020 dd - -rwxr-xr-x 1 root root 93936 Sep 23 2020 df - -rwxr-xr-x 1 root root 147176 Sep 23 2020 dir - -rwxr-xr-x 1 root root 84440 Mar 27 2024 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 39712 Sep 23 2020 echo - -rwxr-xr-x 1 root root 28 Jan 24 2023 egrep - -rwxr-xr-x 1 root root 39680 Sep 23 2020 false - -rwxr-xr-x 1 root root 28 Jan 24 2023 fgrep - -rwxr-xr-x 1 root root 69032 Mar 27 2024 findmnt - -rwsr-xr-x 1 root root 34896 Feb 26 2021 fusermount - -rwxr-xr-x 1 root root 203072 Jan 24 2023 grep - -rwxr-xr-x 2 root root 2346 Apr 9 2022 gunzip - -rwxr-xr-x 1 root root 6447 Apr 9 2022 gzexe - -rwxr-xr-x 1 root root 98048 Apr 9 2022 gzip - -rwxr-xr-x 1 root root 22600 Nov 6 2019 hostname - -rwxr-xr-x 1 root root 72840 Sep 23 2020 ln - -rwxr-xr-x 1 root root 56952 Feb 7 2020 login - -rwxr-xr-x 1 root root 147176 Sep 23 2020 ls - -rwxr-xr-x 1 root root 149736 Mar 27 2024 lsblk - -rwxr-xr-x 1 root root 85184 Sep 23 2020 mkdir - -rwxr-xr-x 1 root root 76896 Sep 23 2020 mknod - -rwxr-xr-x 1 root root 48064 Sep 23 2020 mktemp - -rwxr-xr-x 1 root root 59632 Mar 27 2024 more - -rwsr-xr-x 1 root root 55528 Mar 27 2024 mount - -rwxr-xr-x 1 root root 18664 Mar 27 2024 mountpoint - -rwxr-xr-x 1 root root 147080 Sep 23 2020 mv - lrwxrwxrwx 1 root root 8 Nov 6 2019 nisdomainname -> hostname - lrwxrwxrwx 1 root root 14 Dec 16 2021 pidof -> /sbin/killall5 - -rwxr-xr-x 1 root root 43872 Sep 23 2020 pwd - lrwxrwxrwx 1 root root 4 Mar 27 2022 rbash -> bash - -rwxr-xr-x 1 root root 52032 Sep 23 2020 readlink - -rwxr-xr-x 1 root root 72704 Sep 23 2020 rm - -rwxr-xr-x 1 root root 52032 Sep 23 2020 rmdir - -rwxr-xr-x 1 root root 27472 Sep 27 2020 run-parts - -rwxr-xr-x 1 root root 122224 Dec 22 2018 sed - lrwxrwxrwx 1 root root 4 Aug 9 03:46 sh -> dash - -rwxr-xr-x 1 root root 43808 Sep 23 2020 sleep - -rwxr-xr-x 1 root root 84928 Sep 23 2020 stty - -rwsr-xr-x 1 root root 71912 Mar 27 2024 su - -rwxr-xr-x 1 root root 39744 Sep 23 2020 sync - -rwxr-xr-x 1 root root 531928 Jan 19 2024 tar - -rwxr-xr-x 1 root root 14456 Sep 27 2020 tempfile - -rwxr-xr-x 1 root root 101408 Sep 23 2020 touch - -rwxr-xr-x 1 root root 39680 Sep 23 2020 true - -rwxr-xr-x 1 root root 14328 Feb 26 2021 ulockmgr_server - -rwsr-xr-x 1 root root 35040 Mar 27 2024 umount - -rwxr-xr-x 1 root root 39744 Sep 23 2020 uname - -rwxr-xr-x 2 root root 2346 Apr 9 2022 uncompress - -rwxr-xr-x 1 root root 147176 Sep 23 2020 vdir - -rwxr-xr-x 1 root root 63744 Mar 27 2024 wdctl - lrwxrwxrwx 1 root root 8 Nov 6 2019 ypdomainname -> hostname - -rwxr-xr-x 1 root root 1984 Apr 9 2022 zcat - -rwxr-xr-x 1 root root 1678 Apr 9 2022 zcmp - -rwxr-xr-x 1 root root 5898 Apr 9 2022 zdiff - -rwxr-xr-x 1 root root 29 Apr 9 2022 zegrep - -rwxr-xr-x 1 root root 29 Apr 9 2022 zfgrep - -rwxr-xr-x 1 root root 2081 Apr 9 2022 zforce - -rwxr-xr-x 1 root root 8049 Apr 9 2022 zgrep - -rwxr-xr-x 1 root root 2206 Apr 9 2022 zless - -rwxr-xr-x 1 root root 1842 Apr 9 2022 zmore - -rwxr-xr-x 1 root root 4577 Apr 9 2022 znew -I: user script /srv/workspace/pbuilder/2631684/tmp/hooks/D02_print_environment finished + -rwxr-xr-x 1 root root 1234376 Mar 28 2022 bash + -rwxr-xr-x 3 root root 38984 Jul 21 2020 bunzip2 + -rwxr-xr-x 3 root root 38984 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 38984 Jul 21 2020 bzip2 + -rwxr-xr-x 1 root root 18424 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 43936 Sep 24 2020 cat + -rwxr-xr-x 1 root root 72672 Sep 24 2020 chgrp + -rwxr-xr-x 1 root root 64448 Sep 24 2020 chmod + -rwxr-xr-x 1 root root 72672 Sep 24 2020 chown + -rwxr-xr-x 1 root root 151168 Sep 24 2020 cp + -rwxr-xr-x 1 root root 125560 Dec 11 2020 dash + -rwxr-xr-x 1 root root 113664 Sep 24 2020 date + -rwxr-xr-x 1 root root 80968 Sep 24 2020 dd + -rwxr-xr-x 1 root root 93936 Sep 24 2020 df + -rwxr-xr-x 1 root root 147176 Sep 24 2020 dir + -rwxr-xr-x 1 root root 84440 Mar 29 00:09 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 39712 Sep 24 2020 echo + -rwxr-xr-x 1 root root 28 Jan 25 2023 egrep + -rwxr-xr-x 1 root root 39680 Sep 24 2020 false + -rwxr-xr-x 1 root root 28 Jan 25 2023 fgrep + -rwxr-xr-x 1 root root 69032 Mar 29 00:09 findmnt + -rwsr-xr-x 1 root root 34896 Feb 27 2021 fusermount + -rwxr-xr-x 1 root root 203072 Jan 25 2023 grep + -rwxr-xr-x 2 root root 2346 Apr 10 2022 gunzip + -rwxr-xr-x 1 root root 6447 Apr 10 2022 gzexe + -rwxr-xr-x 1 root root 98048 Apr 10 2022 gzip + -rwxr-xr-x 1 root root 22600 Nov 8 2019 hostname + -rwxr-xr-x 1 root root 72840 Sep 24 2020 ln + -rwxr-xr-x 1 root root 56952 Feb 8 2020 login + -rwxr-xr-x 1 root root 147176 Sep 24 2020 ls + -rwxr-xr-x 1 root root 149736 Mar 29 00:09 lsblk + -rwxr-xr-x 1 root root 85184 Sep 24 2020 mkdir + -rwxr-xr-x 1 root root 76896 Sep 24 2020 mknod + -rwxr-xr-x 1 root root 48064 Sep 24 2020 mktemp + -rwxr-xr-x 1 root root 59632 Mar 29 00:09 more + -rwsr-xr-x 1 root root 55528 Mar 29 00:09 mount + -rwxr-xr-x 1 root root 18664 Mar 29 00:09 mountpoint + -rwxr-xr-x 1 root root 147080 Sep 24 2020 mv + lrwxrwxrwx 1 root root 8 Nov 8 2019 nisdomainname -> hostname + lrwxrwxrwx 1 root root 14 Dec 17 2021 pidof -> /sbin/killall5 + -rwxr-xr-x 1 root root 43872 Sep 24 2020 pwd + lrwxrwxrwx 1 root root 4 Mar 28 2022 rbash -> bash + -rwxr-xr-x 1 root root 52032 Sep 24 2020 readlink + -rwxr-xr-x 1 root root 72704 Sep 24 2020 rm + -rwxr-xr-x 1 root root 52032 Sep 24 2020 rmdir + -rwxr-xr-x 1 root root 27472 Sep 28 2020 run-parts + -rwxr-xr-x 1 root root 122224 Dec 23 2018 sed + lrwxrwxrwx 1 root root 9 Jul 23 08:03 sh -> /bin/bash + -rwxr-xr-x 1 root root 43808 Sep 24 2020 sleep + -rwxr-xr-x 1 root root 84928 Sep 24 2020 stty + -rwsr-xr-x 1 root root 71912 Mar 29 00:09 su + -rwxr-xr-x 1 root root 39744 Sep 24 2020 sync + -rwxr-xr-x 1 root root 531928 Jan 20 2024 tar + -rwxr-xr-x 1 root root 14456 Sep 28 2020 tempfile + -rwxr-xr-x 1 root root 101408 Sep 24 2020 touch + -rwxr-xr-x 1 root root 39680 Sep 24 2020 true + -rwxr-xr-x 1 root root 14328 Feb 27 2021 ulockmgr_server + -rwsr-xr-x 1 root root 35040 Mar 29 00:09 umount + -rwxr-xr-x 1 root root 39744 Sep 24 2020 uname + -rwxr-xr-x 2 root root 2346 Apr 10 2022 uncompress + -rwxr-xr-x 1 root root 147176 Sep 24 2020 vdir + -rwxr-xr-x 1 root root 63744 Mar 29 00:09 wdctl + lrwxrwxrwx 1 root root 8 Nov 8 2019 ypdomainname -> hostname + -rwxr-xr-x 1 root root 1984 Apr 10 2022 zcat + -rwxr-xr-x 1 root root 1678 Apr 10 2022 zcmp + -rwxr-xr-x 1 root root 5898 Apr 10 2022 zdiff + -rwxr-xr-x 1 root root 29 Apr 10 2022 zegrep + -rwxr-xr-x 1 root root 29 Apr 10 2022 zfgrep + -rwxr-xr-x 1 root root 2081 Apr 10 2022 zforce + -rwxr-xr-x 1 root root 8049 Apr 10 2022 zgrep + -rwxr-xr-x 1 root root 2206 Apr 10 2022 zless + -rwxr-xr-x 1 root root 1842 Apr 10 2022 zmore + -rwxr-xr-x 1 root root 4577 Apr 10 2022 znew +I: user script /srv/workspace/pbuilder/2701157/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -262,7 +293,7 @@ Get: 47 http://deb.debian.org/debian bullseye/main amd64 libwrap0 amd64 7.6.q-31 [59.0 kB] Get: 48 http://deb.debian.org/debian bullseye/main amd64 libwrap0-dev amd64 7.6.q-31 [21.5 kB] Get: 49 http://deb.debian.org/debian bullseye/main amd64 psmisc amd64 23.4-2 [198 kB] -Fetched 21.8 MB in 0s (102 MB/s) +Fetched 21.8 MB in 1s (30.6 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 ... 19711 files and directories currently installed.) @@ -480,7 +511,11 @@ fakeroot is already the newest version (1.25.3-1.1). 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. I: Building the package -I: Running cd /build/reproducible-path/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 +I: user script /srv/workspace/pbuilder/2701157/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for bullseye +I: user script /srv/workspace/pbuilder/2701157/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/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 @@ -490,7 +525,7 @@ fakeroot debian/rules clean dh clean dh_auto_clean - make -j42 distclean + make -j20 distclean make[1]: Entering directory '/build/reproducible-path/sslh-1.20' Makefile:66: warning: ignoring prerequisites on suffix rule definition rm -f sslh-fork sslh-select echosrv version.h sslh.8.gz systemd-sslh-generator *.o *.gcov *.gcno *.gcda *.png *.html *.css *.info @@ -505,7 +540,7 @@ debian/rules override_dh_auto_build make[1]: Entering directory '/build/reproducible-path/sslh-1.20' dh_auto_build -- USELIBWRAP=1 USELIBCAP=1 - make -j42 "INSTALL=install --strip-program=true" USELIBWRAP=1 USELIBCAP=1 + make -j20 "INSTALL=install --strip-program=true" USELIBWRAP=1 USELIBCAP=1 make[2]: Entering directory '/build/reproducible-path/sslh-1.20' Makefile:66: warning: ignoring prerequisites on suffix rule definition ./genver.sh >version.h @@ -517,14 +552,6 @@ cc -g -O2 -fdebug-prefix-map=/build/reproducible-path/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/reproducible-path/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/reproducible-path/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); @@ -534,34 +561,42 @@ /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/reproducible-path/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/reproducible-path/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/reproducible-path/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 +cc -g -O2 -fdebug-prefix-map=/build/reproducible-path/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 #strip sslh-fork #strip sslh-select make[2]: Leaving directory '/build/reproducible-path/sslh-1.20' make[1]: Leaving directory '/build/reproducible-path/sslh-1.20' dh_auto_test - make -j42 test + make -j20 test make[1]: Entering directory '/build/reproducible-path/sslh-1.20' Makefile:66: warning: ignoring prerequisites on suffix rule definition ./t -./echosrv --listen localhost:33167 --prefix 'ssh: ' -./echosrv --listen localhost:39583 --prefix 'socks5: ' -./echosrv --listen localhost:38525 --prefix 'http: ' -./echosrv --listen localhost:44833 --prefix 'tinc: ' -./echosrv --listen localhost:36643 --prefix 'openvpn: ' -./echosrv --listen localhost:45607 --prefix 'xmpp: ' -./echosrv --listen localhost:42577 --prefix 'adb: ' -./echosrv --listen localhost:41853 --prefix 'tls:sni1;alpn1,alpn2: ' -./echosrv --listen localhost:41819 --prefix 'tls:sni2,sni3;alpn1,alpn2: ' -./echosrv --listen localhost:45589 --prefix 'tls:;alpn3: ' -./echosrv --listen localhost:41341 --prefix 'tls:sni3;: ' -./echosrv --listen localhost:34769 --prefix 'tls: ' -./echosrv --listen localhost:42549 --prefix 'anyprot: ' +./echosrv --listen localhost:37531 --prefix 'ssh: ' +./echosrv --listen localhost:36383 --prefix 'socks5: ' +./echosrv --listen localhost:34905 --prefix 'http: ' +./echosrv --listen localhost:33893 --prefix 'tinc: ' +./echosrv --listen localhost:33375 --prefix 'openvpn: ' +./echosrv --listen localhost:44531 --prefix 'xmpp: ' +./echosrv --listen localhost:33687 --prefix 'adb: ' +./echosrv --listen localhost:40213 --prefix 'tls:sni1;alpn1,alpn2: ' +./echosrv --listen localhost:38675 --prefix 'tls:sni2,sni3;alpn1,alpn2: ' +./echosrv --listen localhost:33661 --prefix 'tls:;alpn3: ' +./echosrv --listen localhost:42807 --prefix 'tls:sni3;: ' +./echosrv --listen localhost:35145 --prefix 'tls: ' +./echosrv --listen localhost:46153 --prefix 'anyprot: ' Testing sslh-select -spawned 2635117 -./sslh-select -v -f -u pbuilder1 -Ftest.cfg +spawned 2722672 +./sslh-select -v -f -u pbuilder2 -Ftest.cfg tls: sni_hostnames[0]: sni1 tls: alpn_protocols[0]: alpn1 tls: alpn_protocols[1]: alpn2 @@ -573,27 +608,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:33167. libwrap service: (null) log_level: 1 family 2 2 [] [fork] -socks5 addr: localhost:39583. libwrap service: (null) log_level: 1 family 2 2 [] [] -http addr: localhost:38525. libwrap service: (null) log_level: 1 family 2 2 [] [] -tinc addr: localhost:44833. libwrap service: (null) log_level: 1 family 2 2 [] [] -openvpn addr: localhost:36643. libwrap service: (null) log_level: 1 family 2 2 [] [] -xmpp addr: localhost:45607. libwrap service: (null) log_level: 1 family 2 2 [] [] -adb addr: localhost:42577. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:41853. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:41819. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:45589. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:41341. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:34769. libwrap service: (null) log_level: 1 family 2 2 [] [] -anyprot addr: localhost:42549. libwrap service: (null) log_level: 1 family 2 2 [] [] +ssh addr: localhost:37531. libwrap service: (null) log_level: 1 family 2 2 [] [fork] +socks5 addr: localhost:36383. libwrap service: (null) log_level: 1 family 2 2 [] [] +http addr: localhost:34905. libwrap service: (null) log_level: 1 family 2 2 [] [] +tinc addr: localhost:33893. libwrap service: (null) log_level: 1 family 2 2 [] [] +openvpn addr: localhost:33375. libwrap service: (null) log_level: 1 family 2 2 [] [] +xmpp addr: localhost:44531. libwrap service: (null) log_level: 1 family 2 2 [] [] +adb addr: localhost:33687. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:40213. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:38675. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:33661. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:42807. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:35145. libwrap service: (null) log_level: 1 family 2 2 [] [] +anyprot addr: localhost:46153. libwrap service: (null) log_level: 1 family 2 2 [] [] listening on: - localhost:37353 [keepalive] + localhost:38111 [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 @@ -625,15 +660,16 @@ timed out, connect to ssh closing fd 5 selecting... max_fd=6 num_probing=0 -connecting to localhost:33167 family 2 len 16 -ssh:connection from localhost:38292 to localhost:37353 forwarded from localhost:40794 to localhost:33167 +connecting to localhost:37531 family 2 len 16 +ssh:connection from localhost:43332 to localhost:38111 forwarded from localhost:45704 to localhost:37531 flushing deferred data to fd 4 ok 1 - Shy SSH connection -socket closed ***Test: One SSL half-started then one SSH +socket closed connection closed down 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 @@ -661,14 +697,12 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:34769 family 2 len 16 -tls:connection from localhost:50110 to localhost:37353 forwarded from localhost:34300 to localhost:34769 -flushing deferred data to fd 6 -selecting... max_fd=7 num_probing=0 -accepted fd 7 on slot 1 +connecting to localhost:35145 family 2 len 16 +tls:connection from localhost:55764 to localhost:38111 forwarded from localhost:57834 to localhost:35145 +flushing deferred data to fd 7 selecting... max_fd=8 num_probing=1 processing fd1 slot 0 -activity on fd6 +activity on fd7 selecting... max_fd=8 num_probing=1 processing fd0 slot 1 hexdump of incoming packet: @@ -694,20 +728,20 @@ selecting... max_fd=8 num_probing=1 processing fd0 slot 1 timed out, connect to ssh -closing fd 7 +closing fd 6 selecting... max_fd=8 num_probing=0 -connecting to localhost:33167 family 2 len 16 -ssh:connection from localhost:50120 to localhost:37353 forwarded from localhost:38006 to localhost:33167 +connecting to localhost:37531 family 2 len 16 +ssh:connection from localhost:55766 to localhost:38111 forwarded from localhost:55746 to localhost:37531 flushing deferred data to fd 4 ok 2 - SSH during SSL being established ok 3 - SSL connection interrupted by SSH -socket closed ***Test: One SSH half-started then one SSL +socket closed +connection closed down processing fd0 slot 0 activity on fd5 closing fd 5 -connection closed down -closing fd 6 +closing fd 7 selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 @@ -740,8 +774,8 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:34769 family 2 len 16 -tls:connection from localhost:59022 to localhost:37353 forwarded from localhost:35842 to localhost:34769 +connecting to localhost:35145 family 2 len 16 +tls:connection from localhost:55018 to localhost:38111 forwarded from localhost:48966 to localhost:35145 flushing deferred data to fd 7 selecting... max_fd=8 num_probing=1 processing fd1 slot 1 @@ -774,18 +808,17 @@ timed out, connect to ssh closing fd 5 selecting... max_fd=8 num_probing=0 -connecting to localhost:33167 family 2 len 16 -ssh:connection from localhost:59012 to localhost:37353 forwarded from localhost:59436 to localhost:33167 +connecting to localhost:37531 family 2 len 16 +ssh:connection from localhost:55016 to localhost:38111 forwarded from localhost:35118 to localhost:37531 flushing deferred data to fd 4 ok 5 - SSH connection interrupted by SSL +socket closed +connection closed down +accepted fd 5 on slot 0 processing fd0 slot 1 activity on fd6 closing fd 6 -socket closed closing fd 7 -selecting... max_fd=8 num_probing=0 -connection closed down -accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 hexdump of incoming packet: @@ -794,8 +827,8 @@ probing for ssh: PROBE_MATCH closing fd 5 selecting... max_fd=8 num_probing=0 -connecting to localhost:33167 family 2 len 16 -ssh:connection from localhost:49930 to localhost:37353 forwarded from localhost:59450 to localhost:33167 +connecting to localhost:37531 family 2 len 16 +ssh:connection from localhost:40760 to localhost:38111 forwarded from localhost:35122 to localhost:37531 flushing deferred data to fd 4 Received: protocol ssh data [SSH-2.0 tester] socket closed @@ -810,20 +843,20 @@ **** writing deferred on fd -1 probing for ssh: PROBE_NEXT probing for socks5: PROBE_MATCH -connecting to localhost:39583 family 2 len 16 -socks5:connection from localhost:49936 to localhost:37353 forwarded from localhost:47732 to localhost:39583 +connecting to localhost:36383 family 2 len 16 +socks5:connection from localhost:40768 to localhost:38111 forwarded from localhost:34126 to localhost:36383 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 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 @@ -835,20 +868,20 @@ probing for ssh: PROBE_NEXT probing for socks5: PROBE_NEXT probing for http: PROBE_MATCH -connecting to localhost:38525 family 2 len 16 -http:connection from localhost:49938 to localhost:37353 forwarded from localhost:60804 to localhost:38525 +connecting to localhost:34905 family 2 len 16 +http:connection from localhost:40778 to localhost:38111 forwarded from localhost:44722 to localhost:34905 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 http data [GET index.html HTTP/1.1] +ok 10 - probe http connected correctly 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 5 on slot 0 selecting... max_fd=8 num_probing=1 @@ -860,8 +893,8 @@ probing for socks5: PROBE_NEXT probing for http: PROBE_NEXT probing for tinc: PROBE_MATCH -connecting to localhost:44833 family 2 len 16 -tinc:connection from localhost:49944 to localhost:37353 forwarded from localhost:47096 to localhost:44833 +connecting to localhost:33893 family 2 len 16 +tinc:connection from localhost:40792 to localhost:38111 forwarded from localhost:44244 to localhost:33893 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -886,20 +919,20 @@ probing for http: PROBE_AGAIN probing for tinc: PROBE_NEXT probing for openvpn: PROBE_MATCH -connecting to localhost:36643 family 2 len 16 -openvpn:connection from localhost:49954 to localhost:37353 forwarded from localhost:47856 to localhost:36643 +connecting to localhost:33375 family 2 len 16 +openvpn:connection from localhost:40802 to localhost:38111 forwarded from localhost:41264 to localhost:33375 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 openvpn data [] +ok 14 - probe openvpn connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 selecting... max_fd=8 num_probing=0 -ok 14 - probe openvpn connected correctly ok 15 - data shoveled correctly accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 @@ -916,21 +949,21 @@ probing for tinc: PROBE_NEXT probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_MATCH -connecting to localhost:45607 family 2 len 16 -xmpp:connection from localhost:49970 to localhost:37353 forwarded from localhost:52940 to localhost:45607 +connecting to localhost:44531 family 2 len 16 +xmpp:connection from localhost:40818 to localhost:38111 forwarded from localhost:50354 to localhost:44531 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 xmpp data [I should get a real jabber connection initialisation here] +ok 16 - probe xmpp connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 16 - probe xmpp connected correctly ok 17 - data shoveled correctly +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -945,8 +978,8 @@ probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_AGAIN probing for adb: PROBE_MATCH -connecting to localhost:42577 family 2 len 16 -adb:connection from localhost:49972 to localhost:37353 forwarded from localhost:42180 to localhost:42577 +connecting to localhost:33687 family 2 len 16 +adb:connection from localhost:40828 to localhost:38111 forwarded from localhost:43672 to localhost:33687 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -991,8 +1024,8 @@ matching [sni1] with [sni1] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41853 family 2 len 16 -tls:connection from localhost:49988 to localhost:37353 forwarded from localhost:57376 to localhost:41853 +connecting to localhost:40213 family 2 len 16 +tls:connection from localhost:40834 to localhost:38111 forwarded from localhost:42086 to localhost:40213 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1041,8 +1074,8 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41853 family 2 len 16 -tls:connection from localhost:49996 to localhost:37353 forwarded from localhost:57390 to localhost:41853 +connecting to localhost:40213 family 2 len 16 +tls:connection from localhost:40844 to localhost:38111 forwarded from localhost:42092 to localhost:40213 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1055,9 +1088,9 @@ processing fd0 slot 0 activity on fd5 closing fd 5 +ok 22 - probe tls:sni1;alpn1,alpn2 connected correctly closing fd 6 selecting... max_fd=8 num_probing=0 -ok 22 - probe tls:sni1;alpn1,alpn2 connected correctly ok 23 - data shoveled correctly sni: sni2 alpn: alpn1 @@ -1092,8 +1125,8 @@ matching [sni2] with [sni2] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:50000 to localhost:37353 forwarded from localhost:44524 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:40854 to localhost:38111 forwarded from localhost:58726 to localhost:38675 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1144,8 +1177,8 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:50014 to localhost:37353 forwarded from localhost:44538 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:40860 to localhost:38111 forwarded from localhost:58728 to localhost:38675 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1155,13 +1188,13 @@ 9 3=<5/_ sni2  # alpn2hello sni/alpn] +ok 26 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly 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 +selecting... max_fd=8 num_probing=0 sni: sni3 alpn: alpn1 accepted fd 5 on slot 0 @@ -1196,8 +1229,8 @@ matching [sni3] with [sni3] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:50028 to localhost:37353 forwarded from localhost:44554 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:40874 to localhost:38111 forwarded from localhost:58730 to localhost:38675 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1207,12 +1240,12 @@ 9 3=<5/_ sni3  # alpn1hello sni/alpn] +ok 28 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly 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 @@ -1249,8 +1282,8 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:50034 to localhost:37353 forwarded from localhost:44562 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:40882 to localhost:38111 forwarded from localhost:58732 to localhost:38675 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1260,13 +1293,13 @@ 9 3=<5/_ sni3  # alpn2hello sni/alpn] +ok 30 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 30 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 31 - data shoveled correctly +selecting... max_fd=8 num_probing=0 sni: alpn: alpn3 accepted fd 5 on slot 0 @@ -1304,8 +1337,8 @@ probing for tls: PROBE_NEXT matching [alpn3] with [alpn3] probing for tls: PROBE_MATCH -connecting to localhost:45589 family 2 len 16 -tls:connection from localhost:50036 to localhost:37353 forwarded from localhost:35112 to localhost:45589 +connecting to localhost:33661 family 2 len 16 +tls:connection from localhost:40884 to localhost:38111 forwarded from localhost:50854 to localhost:33661 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1315,15 +1348,15 @@ 9 3=<5/R  # alpn3hello alpn] +ok 32 - probe tls:;alpn3 connected correctly processing fd0 slot 0 +ok 33 - data shoveled correctly activity on fd5 closing fd 5 -closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 32 - probe tls:;alpn3 connected correctly -ok 33 - data shoveled correctly sni: sni3 alpn: +closing fd 6 +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -1357,8 +1390,8 @@ probing for tls: PROBE_NEXT matching [sni3] with [sni3] probing for tls: PROBE_MATCH -connecting to localhost:41341 family 2 len 16 -tls:connection from localhost:50052 to localhost:37353 forwarded from localhost:36380 to localhost:41341 +connecting to localhost:42807 family 2 len 16 +tls:connection from localhost:40892 to localhost:38111 forwarded from localhost:52400 to localhost:42807 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1368,13 +1401,13 @@ 9 3=<5/S sni3  # hello sni] -processing fd0 slot 0 ok 34 - probe tls:sni3; connected correctly +processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 ok 35 - data shoveled correctly +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -1404,8 +1437,8 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:34769 family 2 len 16 -tls:connection from localhost:50064 to localhost:37353 forwarded from localhost:56036 to localhost:34769 +connecting to localhost:35145 family 2 len 16 +tls:connection from localhost:40894 to localhost:38111 forwarded from localhost:47030 to localhost:35145 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1415,13 +1448,13 @@ 9 3=<5/F  # hello ssl alone] +ok 36 - probe tls connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 36 - probe tls connected correctly ok 37 - data shoveled correctly +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -1453,21 +1486,21 @@ probing for tls: PROBE_NEXT Request did not begin with TLS handshake. probing for tls: PROBE_NEXT -connecting to localhost:42549 family 2 len 16 -anyprot:connection from localhost:50078 to localhost:37353 forwarded from localhost:37798 to localhost:42549 +connecting to localhost:46153 family 2 len 16 +anyprot:connection from localhost:40910 to localhost:38111 forwarded from localhost:42166 to localhost:46153 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 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 processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 38 - probe anyprot connected correctly ok 39 - data shoveled correctly +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -1528,8 +1561,8 @@ probing for ssh: PROBE_MATCH closing fd 5 selecting... max_fd=8 num_probing=0 -connecting to localhost:33167 family 2 len 16 -ssh:connection from localhost:50092 to localhost:37353 forwarded from localhost:59452 to localhost:33167 +connecting to localhost:37531 family 2 len 16 +ssh:connection from localhost:40924 to localhost:38111 forwarded from localhost:35138 to localhost:37531 flushing deferred data to fd 4 Received: protocol ssh data [SSH-2.0 tester] socket closed @@ -1634,20 +1667,20 @@ **** writing deferred on fd -1 probing for ssh: PROBE_NEXT probing for socks5: PROBE_MATCH -connecting to localhost:39583 family 2 len 16 -socks5:connection from localhost:50094 to localhost:37353 forwarded from localhost:47740 to localhost:39583 +connecting to localhost:36383 family 2 len 16 +socks5:connection from localhost:40930 to localhost:38111 forwarded from localhost:34132 to localhost:36383 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 42 - probe socks5 connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 selecting... max_fd=8 num_probing=0 -ok 42 - probe socks5 connected correctly ok 43 - data shoveled correctly accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 @@ -1659,20 +1692,20 @@ probing for ssh: PROBE_NEXT probing for socks5: PROBE_NEXT probing for http: PROBE_MATCH -connecting to localhost:38525 family 2 len 16 -http:connection from localhost:50100 to localhost:37353 forwarded from localhost:60820 to localhost:38525 +connecting to localhost:34905 family 2 len 16 +http:connection from localhost:40934 to localhost:38111 forwarded from localhost:44726 to localhost:34905 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 http data [GET index.html HTTP/1.1] +ok 44 - probe http connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 selecting... max_fd=8 num_probing=0 -ok 44 - probe http connected correctly ok 45 - data shoveled correctly accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 @@ -1684,21 +1717,21 @@ probing for socks5: PROBE_NEXT probing for http: PROBE_NEXT probing for tinc: PROBE_MATCH -connecting to localhost:44833 family 2 len 16 -tinc:connection from localhost:50114 to localhost:37353 forwarded from localhost:47104 to localhost:44833 +connecting to localhost:33893 family 2 len 16 +tinc:connection from localhost:40944 to localhost:38111 forwarded from localhost:44250 to localhost:33893 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 tinc data [0 hello] +ok 46 - probe tinc connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 46 - probe tinc connected correctly ok 47 - data shoveled correctly +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -1710,21 +1743,21 @@ probing for http: PROBE_AGAIN probing for tinc: PROBE_NEXT probing for openvpn: PROBE_MATCH -connecting to localhost:36643 family 2 len 16 -openvpn:connection from localhost:50122 to localhost:37353 forwarded from localhost:47872 to localhost:36643 +connecting to localhost:33375 family 2 len 16 +openvpn:connection from localhost:40960 to localhost:38111 forwarded from localhost:41280 to localhost:33375 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 openvpn data [] +ok 48 - probe openvpn connected correctly processing fd0 slot 0 activity on fd5 -ok 48 - probe openvpn connected correctly closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 ok 49 - data shoveled correctly +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -1740,20 +1773,20 @@ probing for tinc: PROBE_NEXT probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_MATCH -connecting to localhost:45607 family 2 len 16 -xmpp:connection from localhost:50124 to localhost:37353 forwarded from localhost:52942 to localhost:45607 +connecting to localhost:44531 family 2 len 16 +xmpp:connection from localhost:40962 to localhost:38111 forwarded from localhost:50364 to localhost:44531 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 xmpp data [I should get a real jabber connection initialisation here] +ok 50 - probe xmpp connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 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 @@ -1769,8 +1802,8 @@ probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_AGAIN probing for adb: PROBE_MATCH -connecting to localhost:42577 family 2 len 16 -adb:connection from localhost:50138 to localhost:37353 forwarded from localhost:42190 to localhost:42577 +connecting to localhost:33687 family 2 len 16 +adb:connection from localhost:40976 to localhost:38111 forwarded from localhost:43680 to localhost:33687 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1815,8 +1848,8 @@ matching [sni1] with [sni1] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41853 family 2 len 16 -tls:connection from localhost:50154 to localhost:37353 forwarded from localhost:57398 to localhost:41853 +connecting to localhost:40213 family 2 len 16 +tls:connection from localhost:40992 to localhost:38111 forwarded from localhost:42102 to localhost:40213 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1865,8 +1898,8 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41853 family 2 len 16 -tls:connection from localhost:50160 to localhost:37353 forwarded from localhost:57400 to localhost:41853 +connecting to localhost:40213 family 2 len 16 +tls:connection from localhost:40994 to localhost:38111 forwarded from localhost:42116 to localhost:40213 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1876,15 +1909,15 @@ 9 3=<5/_ sni1  # alpn2hello sni/alpn] +ok 56 - probe tls:sni1;alpn1,alpn2 connected correctly processing fd0 slot 0 +ok 57 - data shoveled correctly activity on fd5 closing fd 5 -closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 56 - probe tls:sni1;alpn1,alpn2 connected correctly -ok 57 - data shoveled correctly sni: sni2 alpn: alpn1 +closing fd 6 +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -1916,8 +1949,8 @@ matching [sni2] with [sni2] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:50176 to localhost:37353 forwarded from localhost:44578 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:40996 to localhost:38111 forwarded from localhost:58736 to localhost:38675 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1927,15 +1960,15 @@ 9 3=<5/_ sni2  # alpn1hello sni/alpn] +ok 58 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 58 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 59 - data shoveled correctly sni: sni2 alpn: alpn2 +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -1968,8 +2001,8 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:50180 to localhost:37353 forwarded from localhost:44586 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:41004 to localhost:38111 forwarded from localhost:58740 to localhost:38675 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -1979,13 +2012,13 @@ 9 3=<5/_ sni2  # alpn2hello sni/alpn] +ok 60 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 60 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 61 - data shoveled correctly +selecting... max_fd=8 num_probing=0 sni: sni3 alpn: alpn1 accepted fd 5 on slot 0 @@ -2020,8 +2053,8 @@ matching [sni3] with [sni3] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:50182 to localhost:37353 forwarded from localhost:44598 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:41020 to localhost:38111 forwarded from localhost:58752 to localhost:38675 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -2031,15 +2064,15 @@ 9 3=<5/_ sni3  # alpn1hello sni/alpn] +ok 62 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 62 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 63 - data shoveled correctly sni: sni3 alpn: alpn2 +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -2073,8 +2106,8 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:50186 to localhost:37353 forwarded from localhost:44602 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:41032 to localhost:38111 forwarded from localhost:58762 to localhost:38675 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -2128,8 +2161,8 @@ probing for tls: PROBE_NEXT matching [alpn3] with [alpn3] probing for tls: PROBE_MATCH -connecting to localhost:45589 family 2 len 16 -tls:connection from localhost:50200 to localhost:37353 forwarded from localhost:35114 to localhost:45589 +connecting to localhost:33661 family 2 len 16 +tls:connection from localhost:41040 to localhost:38111 forwarded from localhost:50858 to localhost:33661 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -2139,12 +2172,12 @@ 9 3=<5/R  # alpn3hello alpn] +ok 66 - probe tls:;alpn3 connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 selecting... max_fd=8 num_probing=0 -ok 66 - probe tls:;alpn3 connected correctly ok 67 - data shoveled correctly sni: sni3 alpn: @@ -2181,8 +2214,8 @@ probing for tls: PROBE_NEXT matching [sni3] with [sni3] probing for tls: PROBE_MATCH -connecting to localhost:41341 family 2 len 16 -tls:connection from localhost:50216 to localhost:37353 forwarded from localhost:36390 to localhost:41341 +connecting to localhost:42807 family 2 len 16 +tls:connection from localhost:41048 to localhost:38111 forwarded from localhost:52402 to localhost:42807 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -2192,13 +2225,13 @@ 9 3=<5/S sni3  # hello sni] +ok 68 - probe tls:sni3; connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 -selecting... max_fd=8 num_probing=0 -ok 68 - probe tls:sni3; connected correctly ok 69 - data shoveled correctly +selecting... max_fd=8 num_probing=0 accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 processing fd0 slot 0 @@ -2228,8 +2261,8 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:34769 family 2 len 16 -tls:connection from localhost:50230 to localhost:37353 forwarded from localhost:56052 to localhost:34769 +connecting to localhost:35145 family 2 len 16 +tls:connection from localhost:41064 to localhost:38111 forwarded from localhost:47036 to localhost:35145 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -2239,12 +2272,12 @@ 9 3=<5/F  # hello ssl alone] +ok 70 - probe tls connected correctly processing fd0 slot 0 activity on fd5 closing fd 5 closing fd 6 selecting... max_fd=8 num_probing=0 -ok 70 - probe tls connected correctly ok 71 - data shoveled correctly accepted fd 5 on slot 0 selecting... max_fd=8 num_probing=1 @@ -2277,8 +2310,8 @@ probing for tls: PROBE_NEXT Request did not begin with TLS handshake. probing for tls: PROBE_NEXT -connecting to localhost:42549 family 2 len 16 -anyprot:connection from localhost:50242 to localhost:37353 forwarded from localhost:37810 to localhost:42549 +connecting to localhost:46153 family 2 len 16 +anyprot:connection from localhost:41068 to localhost:38111 forwarded from localhost:42178 to localhost:46153 flushing deferred data to fd 6 selecting... max_fd=8 num_probing=0 processing fd1 slot 0 @@ -2292,11 +2325,11 @@ selecting... max_fd=8 num_probing=0 ok 72 - probe anyprot connected correctly ok 73 - data shoveled correctly -killing 2635120 +killing 2722673 Testing sslh-fork -spawned 2639909 -./sslh-fork -v -f -u pbuilder1 -Ftest.cfg +spawned 2733683 +./sslh-fork -v -f -u pbuilder2 -Ftest.cfg tls: sni_hostnames[0]: sni1 tls: alpn_protocols[0]: alpn1 tls: alpn_protocols[1]: alpn2 @@ -2308,27 +2341,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:33167. libwrap service: (null) log_level: 1 family 2 2 [] [fork] -socks5 addr: localhost:39583. libwrap service: (null) log_level: 1 family 2 2 [] [] -http addr: localhost:38525. libwrap service: (null) log_level: 1 family 2 2 [] [] -tinc addr: localhost:44833. libwrap service: (null) log_level: 1 family 2 2 [] [] -openvpn addr: localhost:36643. libwrap service: (null) log_level: 1 family 2 2 [] [] -xmpp addr: localhost:45607. libwrap service: (null) log_level: 1 family 2 2 [] [] -adb addr: localhost:42577. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:41853. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:41819. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:45589. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:41341. libwrap service: (null) log_level: 1 family 2 2 [] [] -tls addr: localhost:34769. libwrap service: (null) log_level: 1 family 2 2 [] [] -anyprot addr: localhost:42549. libwrap service: (null) log_level: 1 family 2 2 [] [] +ssh addr: localhost:37531. libwrap service: (null) log_level: 1 family 2 2 [] [fork] +socks5 addr: localhost:36383. libwrap service: (null) log_level: 1 family 2 2 [] [] +http addr: localhost:34905. libwrap service: (null) log_level: 1 family 2 2 [] [] +tinc addr: localhost:33893. libwrap service: (null) log_level: 1 family 2 2 [] [] +openvpn addr: localhost:33375. libwrap service: (null) log_level: 1 family 2 2 [] [] +xmpp addr: localhost:44531. libwrap service: (null) log_level: 1 family 2 2 [] [] +adb addr: localhost:33687. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:40213. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:38675. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:33661. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:42807. libwrap service: (null) log_level: 1 family 2 2 [] [] +tls addr: localhost:35145. libwrap service: (null) log_level: 1 family 2 2 [] [] +anyprot addr: localhost:46153. libwrap service: (null) log_level: 1 family 2 2 [] [] listening on: - localhost:37353 [keepalive] + localhost:38111 [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 @@ -2353,12 +2386,12 @@ Request did not begin with TLS handshake. probing for tls: PROBE_NEXT timed out, connect to ssh -connecting to localhost:33167 family 2 len 16 -ssh:connection from localhost:38736 to localhost:37353 forwarded from localhost:40060 to localhost:33167 +connecting to localhost:37531 family 2 len 16 +ssh:connection from localhost:50440 to localhost:38111 forwarded from localhost:38758 to localhost:37531 flushing deferred data to fd 3 ok 74 - Shy SSH connection -server socket closed ***Test: One SSL half-started then one SSH +server socket closed connection closed down accepted fd 5 accepted fd 5 @@ -2388,8 +2421,8 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:34769 family 2 len 16 -tls:connection from localhost:58912 to localhost:37353 forwarded from localhost:45762 to localhost:34769 +connecting to localhost:35145 family 2 len 16 +tls:connection from localhost:38550 to localhost:38111 forwarded from localhost:58908 to localhost:35145 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. @@ -2412,17 +2445,17 @@ Request did not begin with TLS handshake. probing for tls: PROBE_NEXT timed out, connect to ssh -connecting to localhost:33167 family 2 len 16 -ssh:connection from localhost:58928 to localhost:37353 forwarded from localhost:56820 to localhost:33167 +connecting to localhost:37531 family 2 len 16 +ssh:connection from localhost:38562 to localhost:38111 forwarded from localhost:33632 to localhost:37531 flushing deferred data to fd 3 ok 75 - SSH during SSL being established ok 76 - SSL connection interrupted by SSH server socket closed ***Test: One SSH half-started then one SSL -server socket closed -connection closed down connection closed down accepted fd 5 +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 @@ -2450,8 +2483,8 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:34769 family 2 len 16 -tls:connection from localhost:55100 to localhost:37353 forwarded from localhost:37830 to localhost:34769 +connecting to localhost:35145 family 2 len 16 +tls:connection from localhost:52144 to localhost:38111 forwarded from localhost:60002 to localhost:35145 flushing deferred data to fd 3 ok 77 - SSL during SSH being established hexdump of incoming packet: @@ -2475,40 +2508,40 @@ Request did not begin with TLS handshake. probing for tls: PROBE_NEXT timed out, connect to ssh -connecting to localhost:33167 family 2 len 16 -ssh:connection from localhost:55096 to localhost:37353 forwarded from localhost:54434 to localhost:33167 +connecting to localhost:37531 family 2 len 16 +ssh:connection from localhost:52136 to localhost:38111 forwarded from localhost:49718 to localhost:37531 flushing deferred data to fd 3 ok 78 - SSH connection interrupted by SSL server socket closed -server socket closed -connection closed down connection closed down accepted fd 5 +server socket closed +connection closed down 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 -connecting to localhost:33167 family 2 len 16 -ssh:connection from localhost:57934 to localhost:37353 forwarded from localhost:54450 to localhost:33167 +connecting to localhost:37531 family 2 len 16 +ssh:connection from localhost:44020 to localhost:38111 forwarded from localhost:49722 to localhost:37531 flushing deferred data to fd 3 Received: protocol ssh data [SSH-2.0 tester] -server socket closed -connection closed down ok 79 - probe ssh connected correctly ok 80 - data shoveled correctly accepted fd 5 +server socket closed +connection closed down hexdump of incoming packet: 0x000000: 05 04 01 02 03 04 ...... **** writing deferred on fd -1 probing for ssh: PROBE_NEXT probing for socks5: PROBE_MATCH -connecting to localhost:39583 family 2 len 16 -socks5:connection from localhost:57938 to localhost:37353 forwarded from localhost:47598 to localhost:39583 +connecting to localhost:36383 family 2 len 16 +socks5:connection from localhost:44026 to localhost:38111 forwarded from localhost:59096 to localhost:36383 flushing deferred data to fd 3 Received: protocol socks5 data [] +ok 81 - probe socks5 connected correctly server socket closed connection closed down -ok 81 - probe socks5 connected correctly ok 82 - data shoveled correctly accepted fd 5 hexdump of incoming packet: @@ -2518,8 +2551,8 @@ probing for ssh: PROBE_NEXT probing for socks5: PROBE_NEXT probing for http: PROBE_MATCH -connecting to localhost:38525 family 2 len 16 -http:connection from localhost:57944 to localhost:37353 forwarded from localhost:59238 to localhost:38525 +connecting to localhost:34905 family 2 len 16 +http:connection from localhost:44038 to localhost:38111 forwarded from localhost:43014 to localhost:34905 flushing deferred data to fd 3 Received: protocol http data [GET index.html HTTP/1.1] server socket closed @@ -2534,14 +2567,14 @@ probing for socks5: PROBE_NEXT probing for http: PROBE_NEXT probing for tinc: PROBE_MATCH -connecting to localhost:44833 family 2 len 16 -tinc:connection from localhost:57958 to localhost:37353 forwarded from localhost:35060 to localhost:44833 +connecting to localhost:33893 family 2 len 16 +tinc:connection from localhost:44054 to localhost:38111 forwarded from localhost:34028 to localhost:33893 flushing deferred data to fd 3 Received: protocol tinc data [0 hello] -server socket closed -connection closed down ok 85 - probe tinc connected correctly ok 86 - data shoveled correctly +server socket closed +connection closed down accepted fd 5 hexdump of incoming packet: 0x000000: 00 00 .. @@ -2551,15 +2584,15 @@ probing for http: PROBE_AGAIN probing for tinc: PROBE_NEXT probing for openvpn: PROBE_MATCH -connecting to localhost:36643 family 2 len 16 -openvpn:connection from localhost:57962 to localhost:37353 forwarded from localhost:34036 to localhost:36643 +connecting to localhost:33375 family 2 len 16 +openvpn:connection from localhost:44062 to localhost:38111 forwarded from localhost:58270 to localhost:33375 flushing deferred data to fd 3 Received: protocol openvpn data [] -server socket closed -connection closed down ok 87 - probe openvpn connected correctly ok 88 - data shoveled correctly accepted fd 5 +server socket closed +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 @@ -2572,14 +2605,14 @@ probing for tinc: PROBE_NEXT probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_MATCH -connecting to localhost:45607 family 2 len 16 -xmpp:connection from localhost:57972 to localhost:37353 forwarded from localhost:40022 to localhost:45607 +connecting to localhost:44531 family 2 len 16 +xmpp:connection from localhost:44076 to localhost:38111 forwarded from localhost:58066 to localhost:44531 flushing deferred data to fd 3 Received: protocol xmpp data [I should get a real jabber connection initialisation here] -server socket closed -connection closed down ok 89 - probe xmpp connected correctly ok 90 - data shoveled correctly +server socket closed +connection closed down accepted fd 5 hexdump of incoming packet: 0x000000: 43 4e 58 4e 2e 2e 2e 2e 2e 2e 2e 2e 2e 2e 2e 2e CNXN............ @@ -2592,17 +2625,17 @@ probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_AGAIN probing for adb: PROBE_MATCH -connecting to localhost:42577 family 2 len 16 -adb:connection from localhost:57984 to localhost:37353 forwarded from localhost:37306 to localhost:42577 +connecting to localhost:33687 family 2 len 16 +adb:connection from localhost:44086 to localhost:38111 forwarded from localhost:44612 to localhost:33687 flushing deferred data to fd 3 Received: protocol adb data [CNXN....................host:...] -server socket closed -connection closed down ok 91 - probe adb connected correctly ok 92 - data shoveled correctly sni: sni1 alpn: alpn1 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. @@ -2629,19 +2662,19 @@ matching [sni1] with [sni1] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41853 family 2 len 16 -tls:connection from localhost:57998 to localhost:37353 forwarded from localhost:58392 to localhost:41853 +connecting to localhost:40213 family 2 len 16 +tls:connection from localhost:44096 to localhost:38111 forwarded from localhost:59490 to localhost:40213 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] -server socket closed -connection closed down ok 93 - probe tls:sni1;alpn1,alpn2 connected correctly ok 94 - data shoveled correctly sni: sni1 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 ...............@ @@ -2670,20 +2703,20 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41853 family 2 len 16 -tls:connection from localhost:58004 to localhost:37353 forwarded from localhost:58396 to localhost:41853 +connecting to localhost:40213 family 2 len 16 +tls:connection from localhost:44108 to localhost:38111 forwarded from localhost:59496 to localhost:40213 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 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. @@ -2712,19 +2745,19 @@ matching [sni2] with [sni2] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:58020 to localhost:37353 forwarded from localhost:45958 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:44120 to localhost:38111 forwarded from localhost:60962 to localhost:38675 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 ...............@ @@ -2755,15 +2788,13 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:58028 to localhost:37353 forwarded from localhost:45962 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:44134 to localhost:38111 forwarded from localhost:60968 to localhost:38675 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [@ ]e#p<]' |,8,0̨̩̪+/$(k#'g 9 3=<5/_ sni2  # alpn2hello sni/alpn] -server socket closed -connection closed down ok 99 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 100 - data shoveled correctly sni: sni3 @@ -2775,13 +2806,15 @@ 0x000020: d1 3c 5d 05 19 cb 27 0d 7c 2c 89 00 00 38 c0 2c .<]...'.|,...8., 0x000030: c0 30 00 9f cc a9 cc a8 cc aa c0 2b c0 2f 00 9e .0.........+./.. 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.....=.< +0x000050: 00 39 c0 09 c0 13 00 33 00 9d server socket closed +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 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 .... ........... 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 +0x0000b0: 01 02 02 02 03 00 10 00 08 00 06 05 61 connection closed down +6c 70 6e ............alpn 0x0000c0: 31 00 16 00 00 00 17 00 00 68 65 6c 6c 6f 20 73 1........hello s 0x0000d0: 6e 69 2f 61 6c 70 6e ni/alpn **** writing deferred on fd -1 @@ -2798,8 +2831,8 @@ matching [sni3] with [sni3] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:58040 to localhost:37353 forwarded from localhost:45968 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:44144 to localhost:38111 forwarded from localhost:60978 to localhost:38675 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [@ ]e#p<]' |,8,0̨̩̪+/$(k#'g 9 3=<5/_ sni3  @@ -2842,8 +2875,8 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:58046 to localhost:37353 forwarded from localhost:45984 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:44160 to localhost:38111 forwarded from localhost:60990 to localhost:38675 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [@ ]e#p<]' |,8,0̨̩̪+/$(k#'g 9 3=<5/_ sni3  @@ -2888,16 +2921,16 @@ probing for tls: PROBE_NEXT matching [alpn3] with [alpn3] probing for tls: PROBE_MATCH -connecting to localhost:45589 family 2 len 16 -tls:connection from localhost:58050 to localhost:37353 forwarded from localhost:52848 to localhost:45589 +connecting to localhost:33661 family 2 len 16 +tls:connection from localhost:44170 to localhost:38111 forwarded from localhost:50974 to localhost:33661 flushing deferred data to fd 3 Received: protocol tls:;alpn3 data [␢)1DQT[Qf? +$V8,0̨̩̪+/$(k#'g 9 3=<5/R  # alpn3hello alpn] +ok 105 - probe tls:;alpn3 connected correctly server socket closed connection closed down -ok 105 - probe tls:;alpn3 connected correctly ok 106 - data shoveled correctly sni: sni3 alpn: @@ -2932,16 +2965,16 @@ probing for tls: PROBE_NEXT matching [sni3] with [sni3] probing for tls: PROBE_MATCH -connecting to localhost:41341 family 2 len 16 -tls:connection from localhost:58052 to localhost:37353 forwarded from localhost:38112 to localhost:41341 +connecting to localhost:42807 family 2 len 16 +tls:connection from localhost:44172 to localhost:38111 forwarded from localhost:53618 to localhost:42807 flushing deferred data to fd 3 Received: protocol tls:sni3; data [魆!['KUP/7%Y728,0̨̩̪+/$(k#'g 9 3=<5/S sni3  # hello sni] +ok 107 - probe tls:sni3; connected correctly server socket closed connection closed down -ok 107 - probe tls:sni3; connected correctly ok 108 - data shoveled correctly accepted fd 5 hexdump of incoming packet: @@ -2970,18 +3003,18 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:34769 family 2 len 16 -tls:connection from localhost:58056 to localhost:37353 forwarded from localhost:53476 to localhost:34769 +connecting to localhost:35145 family 2 len 16 +tls:connection from localhost:44184 to localhost:38111 forwarded from localhost:53492 to localhost:35145 flushing deferred data to fd 3 Received: protocol tls data ["3CzÉEQ<($jxؐXe-u8,0̨̩̪+/$(k#'g 9 3=<5/F  # hello ssl alone] -server socket closed -connection closed down ok 109 - probe tls connected correctly ok 110 - data shoveled correctly accepted fd 5 +server socket closed +connection closed down 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 @@ -3010,47 +3043,17 @@ probing for tls: PROBE_NEXT Request did not begin with TLS handshake. probing for tls: PROBE_NEXT -connecting to localhost:42549 family 2 len 16 -anyprot:connection from localhost:58062 to localhost:37353 forwarded from localhost:53938 to localhost:42549 +connecting to localhost:46153 family 2 len 16 +anyprot:connection from localhost:44196 to localhost:38111 forwarded from localhost:47720 to localhost:46153 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 111 - probe anyprot connected correctly ok 112 - data shoveled correctly +server socket closed accepted fd 5 +connection closed down hexdump of incoming packet: -0x000000: 53 S -**** writing deferred on fd -1 -probing for ssh: PROBE_AGAIN -probing for socks5: PROBE_AGAIN -probing for http: PROBE_AGAIN -probing for tinc: PROBE_AGAIN -probing for openvpn: PROBE_AGAIN -probing for xmpp: PROBE_AGAIN -probing for adb: PROBE_AGAIN -probing for tls: PROBE_AGAIN -probing for tls: PROBE_AGAIN -probing for tls: PROBE_AGAIN -probing for tls: PROBE_AGAIN -probing for tls: PROBE_AGAIN -hexdump of incoming packet: -0x000000: 53 S -**** writing deferred on fd -1 -probing for ssh: PROBE_AGAIN -probing for socks5: PROBE_NEXT -probing for http: PROBE_AGAIN -probing for tinc: PROBE_NEXT -probing for openvpn: PROBE_NEXT -probing for xmpp: PROBE_AGAIN -probing for adb: PROBE_AGAIN -probing for tls: PROBE_AGAIN -probing for tls: PROBE_AGAIN -probing for tls: PROBE_AGAIN -probing for tls: PROBE_AGAIN -probing for tls: PROBE_AGAIN -hexdump of incoming packet: -0x000000: 48 H +0x000000: 53 53 48 SSH **** writing deferred on fd -1 probing for ssh: PROBE_AGAIN probing for socks5: PROBE_NEXT @@ -3068,14 +3071,14 @@ 0x000000: 2d - **** writing deferred on fd -1 probing for ssh: PROBE_MATCH -connecting to localhost:33167 family 2 len 16 -ssh:connection from localhost:58068 to localhost:37353 forwarded from localhost:54458 to localhost:33167 +connecting to localhost:37531 family 2 len 16 +ssh:connection from localhost:44202 to localhost:38111 forwarded from localhost:49734 to localhost:37531 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 +server socket closed +connection closed down accepted fd 5 hexdump of incoming packet: 0x000000: 05 . @@ -3162,8 +3165,8 @@ **** writing deferred on fd -1 probing for ssh: PROBE_NEXT probing for socks5: PROBE_MATCH -connecting to localhost:39583 family 2 len 16 -socks5:connection from localhost:58078 to localhost:37353 forwarded from localhost:47608 to localhost:39583 +connecting to localhost:36383 family 2 len 16 +socks5:connection from localhost:44208 to localhost:38111 forwarded from localhost:59100 to localhost:36383 flushing deferred data to fd 3 Received: protocol socks5 data [] server socket closed @@ -3178,14 +3181,14 @@ probing for ssh: PROBE_NEXT probing for socks5: PROBE_NEXT probing for http: PROBE_MATCH -connecting to localhost:38525 family 2 len 16 -http:connection from localhost:58086 to localhost:37353 forwarded from localhost:59252 to localhost:38525 +connecting to localhost:34905 family 2 len 16 +http:connection from localhost:44210 to localhost:38111 forwarded from localhost:43030 to localhost:34905 flushing deferred data to fd 3 Received: protocol http data [GET index.html HTTP/1.1] -server socket closed -connection closed down ok 117 - probe http connected correctly ok 118 - data shoveled correctly +server socket closed +connection closed down accepted fd 5 hexdump of incoming packet: 0x000000: 30 20 68 65 6c 6c 6f 0 hello @@ -3194,14 +3197,14 @@ probing for socks5: PROBE_NEXT probing for http: PROBE_NEXT probing for tinc: PROBE_MATCH -connecting to localhost:44833 family 2 len 16 -tinc:connection from localhost:58096 to localhost:37353 forwarded from localhost:35062 to localhost:44833 +connecting to localhost:33893 family 2 len 16 +tinc:connection from localhost:44220 to localhost:38111 forwarded from localhost:34030 to localhost:33893 flushing deferred data to fd 3 Received: protocol tinc data [0 hello] -server socket closed -connection closed down ok 119 - probe tinc connected correctly ok 120 - data shoveled correctly +server socket closed +connection closed down accepted fd 5 hexdump of incoming packet: 0x000000: 00 00 .. @@ -3211,8 +3214,8 @@ probing for http: PROBE_AGAIN probing for tinc: PROBE_NEXT probing for openvpn: PROBE_MATCH -connecting to localhost:36643 family 2 len 16 -openvpn:connection from localhost:58112 to localhost:37353 forwarded from localhost:34038 to localhost:36643 +connecting to localhost:33375 family 2 len 16 +openvpn:connection from localhost:44226 to localhost:38111 forwarded from localhost:58272 to localhost:33375 flushing deferred data to fd 3 Received: protocol openvpn data [] server socket closed @@ -3232,15 +3235,15 @@ probing for tinc: PROBE_NEXT probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_MATCH -connecting to localhost:45607 family 2 len 16 -xmpp:connection from localhost:58114 to localhost:37353 forwarded from localhost:40038 to localhost:45607 +connecting to localhost:44531 family 2 len 16 +xmpp:connection from localhost:44232 to localhost:38111 forwarded from localhost:58072 to localhost:44531 flushing deferred data to fd 3 Received: protocol xmpp data [I should get a real jabber connection initialisation here] -server socket closed -connection closed down ok 123 - probe xmpp connected correctly ok 124 - data shoveled correctly accepted fd 5 +server socket closed +connection closed down 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:... @@ -3252,16 +3255,16 @@ probing for openvpn: PROBE_NEXT probing for xmpp: PROBE_AGAIN probing for adb: PROBE_MATCH -connecting to localhost:42577 family 2 len 16 -adb:connection from localhost:58116 to localhost:37353 forwarded from localhost:37314 to localhost:42577 +connecting to localhost:33687 family 2 len 16 +adb:connection from localhost:44242 to localhost:38111 forwarded from localhost:44622 to localhost:33687 flushing deferred data to fd 3 Received: protocol adb data [CNXN....................host:...] -server socket closed -connection closed down ok 125 - probe adb connected correctly ok 126 - data shoveled correctly sni: sni1 alpn: alpn1 +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 ...............@ @@ -3289,19 +3292,19 @@ matching [sni1] with [sni1] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41853 family 2 len 16 -tls:connection from localhost:58118 to localhost:37353 forwarded from localhost:58410 to localhost:41853 +connecting to localhost:40213 family 2 len 16 +tls:connection from localhost:44252 to localhost:38111 forwarded from localhost:59500 to localhost:40213 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] -server socket closed -connection closed down ok 127 - probe tls:sni1;alpn1,alpn2 connected correctly +server socket closed ok 128 - data shoveled correctly sni: sni1 alpn: alpn2 +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 ...............@ @@ -3330,17 +3333,17 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41853 family 2 len 16 -tls:connection from localhost:58128 to localhost:37353 forwarded from localhost:58416 to localhost:41853 +connecting to localhost:40213 family 2 len 16 +tls:connection from localhost:44266 to localhost:38111 forwarded from localhost:59504 to localhost:40213 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 +server socket closed +connection closed down sni: sni2 alpn: alpn1 accepted fd 5 @@ -3372,20 +3375,20 @@ matching [sni2] with [sni2] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:58142 to localhost:37353 forwarded from localhost:45998 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:44278 to localhost:38111 forwarded from localhost:60992 to localhost:38675 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. @@ -3415,20 +3418,20 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:58156 to localhost:37353 forwarded from localhost:46008 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:44282 to localhost:38111 forwarded from localhost:60996 to localhost:38675 flushing deferred data to fd 3 Received: protocol tls:sni2,sni3;alpn1,alpn2 data [@ ]e#p<]' |,8,0̨̩̪+/$(k#'g 9 3=<5/_ sni2  # alpn2hello sni/alpn] -server socket closed -connection closed down ok 133 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 134 - data shoveled correctly sni: sni3 alpn: alpn1 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. @@ -3458,19 +3461,19 @@ matching [sni3] with [sni3] matching [alpn1] with [alpn1] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:58168 to localhost:37353 forwarded from localhost:46014 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:44292 to localhost:38111 forwarded from localhost:32776 to localhost:38675 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 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 ...............@ @@ -3502,19 +3505,19 @@ matching [alpn2] with [alpn1] matching [alpn2] with [alpn2] probing for tls: PROBE_MATCH -connecting to localhost:41819 family 2 len 16 -tls:connection from localhost:58174 to localhost:37353 forwarded from localhost:46020 to localhost:41819 +connecting to localhost:38675 family 2 len 16 +tls:connection from localhost:44302 to localhost:38111 forwarded from localhost:32778 to localhost:38675 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 137 - probe tls:sni2,sni3;alpn1,alpn2 connected correctly ok 138 - data shoveled correctly sni: alpn: alpn3 +server socket closed +connection closed down accepted fd 5 hexdump of incoming packet: 0x000000: 16 03 01 00 b7 01 00 00 b3 03 03 e2 90 a2 29 03 ..............). @@ -3548,20 +3551,20 @@ probing for tls: PROBE_NEXT matching [alpn3] with [alpn3] probing for tls: PROBE_MATCH -connecting to localhost:45589 family 2 len 16 -tls:connection from localhost:58186 to localhost:37353 forwarded from localhost:52854 to localhost:45589 +connecting to localhost:33661 family 2 len 16 +tls:connection from localhost:44308 to localhost:38111 forwarded from localhost:50978 to localhost:33661 flushing deferred data to fd 3 Received: protocol tls:;alpn3 data [␢)1DQT[Qf? +$V8,0̨̩̪+/$(k#'g 9 3=<5/R  # alpn3hello alpn] -server socket closed -connection closed down ok 139 - probe tls:;alpn3 connected correctly ok 140 - data shoveled correctly sni: sni3 alpn: accepted fd 5 +server socket closed +connection closed down 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.../ @@ -3592,17 +3595,17 @@ probing for tls: PROBE_NEXT matching [sni3] with [sni3] probing for tls: PROBE_MATCH -connecting to localhost:41341 family 2 len 16 -tls:connection from localhost:58192 to localhost:37353 forwarded from localhost:38128 to localhost:41341 +connecting to localhost:42807 family 2 len 16 +tls:connection from localhost:44314 to localhost:38111 forwarded from localhost:53620 to localhost:42807 flushing deferred data to fd 3 Received: protocol tls:sni3; data [魆!['KUP/7%Y728,0̨̩̪+/$(k#'g 9 3=<5/S sni3  # hello sni] -server socket closed -connection closed down ok 141 - probe tls:sni3; connected correctly ok 142 - 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 @@ -3630,8 +3633,8 @@ probing for tls: PROBE_NEXT probing for tls: PROBE_NEXT probing for tls: PROBE_MATCH -connecting to localhost:34769 family 2 len 16 -tls:connection from localhost:58208 to localhost:37353 forwarded from localhost:53490 to localhost:34769 +connecting to localhost:35145 family 2 len 16 +tls:connection from localhost:44324 to localhost:38111 forwarded from localhost:53500 to localhost:35145 flushing deferred data to fd 3 Received: protocol tls data ["3CzÉEQ<($jxؐXe-u8,0̨̩̪+/$(k#'g 9 3=<5/F  @@ -3670,28 +3673,28 @@ probing for tls: PROBE_NEXT Request did not begin with TLS handshake. probing for tls: PROBE_NEXT -connecting to localhost:42549 family 2 len 16 -anyprot:connection from localhost:58216 to localhost:37353 forwarded from localhost:53952 to localhost:42549 +connecting to localhost:46153 family 2 len 16 +anyprot:connection from localhost:44332 to localhost:38111 forwarded from localhost:47728 to localhost:46153 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 145 - probe anyprot connected correctly server socket closed connection closed down -ok 145 - probe anyprot connected correctly ok 146 - data shoveled correctly -killing 2639910 +killing 2733685 ***Test: Connecting to non-existant server -spawned 2643294 +spawned 2757667 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead -ssh addr: localhost:43347. libwrap service: sshd log_level: 1 family 2 2 [] [fork] -tls addr: localhost:43347. libwrap service: (null) log_level: 1 family 2 2 [] [] +ssh addr: localhost:42645. libwrap service: sshd log_level: 1 family 2 2 [] [fork] +tls addr: localhost:42645. libwrap service: (null) log_level: 1 family 2 2 [] [] listening on: - localhost:37353 [] + localhost:38111 [] 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 @@ -3703,45 +3706,45 @@ probing for ssh: PROBE_NEXT Request did not begin with TLS handshake. probing for tls: PROBE_NEXT -connecting to localhost:43347 family 2 len 16 +connecting to localhost:42645 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 2643967 +spawned 2759799 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead -37353: names must be fully specified as hostname:port +38111: 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 2643969 +spawned 2759822 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead -ssh addr: localhost:33167. libwrap service: sshd log_level: 1 family 2 2 [] [fork] -tls addr: localhost:41341. libwrap service: (null) log_level: 1 family 2 2 [] [] +ssh addr: localhost:37531. libwrap service: sshd log_level: 1 family 2 2 [] [fork] +tls addr: localhost:42807. libwrap service: (null) log_level: 1 family 2 2 [] [] listening on: - localhost:37353 [] + localhost:38111 [] 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 2644033 +spawned 2759848 Usage of 'ssl' setting is deprecated and will be removed in v1.21. Please use 'tls' instead -ssh addr: localhost:33167. libwrap service: sshd log_level: 1 family 2 2 [] [fork] -tls addr: localhost:41341. libwrap service: (null) log_level: 1 family 2 2 [] [] +ssh addr: localhost:37531. libwrap service: sshd log_level: 1 family 2 2 [] [fork] +tls addr: localhost:42807. libwrap service: (null) log_level: 1 family 2 2 [] [] listening on: - localhost:37353 [] + localhost:38111 [] timeout: 2 on-timeout: ssh listening to 1 addresses -/dont_exist//tmp/ZgUi_3cgO0/sslh.pid: No such file or directory +/dont_exist//tmp/uNNzpESJRY/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 2644038 +spawned 2759856 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' @@ -3749,19 +3752,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/reproducible-path/sslh-1.20' create-stamp debian/debhelper-build-stamp @@ -3774,7 +3764,7 @@ make[1]: Entering directory '/build/reproducible-path/sslh-1.20' # auto install fork version, see debian/install for select version dh_auto_install -- DESTDIR=/build/reproducible-path/sslh-1.20/debian/sslh/usr PREFIX=/ install - make -j42 install DESTDIR=/build/reproducible-path/sslh-1.20/debian/sslh AM_UPDATE_INFO_DIR=no "INSTALL=install --strip-program=true" DESTDIR=/build/reproducible-path/sslh-1.20/debian/sslh/usr PREFIX=/ install + make -j20 install DESTDIR=/build/reproducible-path/sslh-1.20/debian/sslh AM_UPDATE_INFO_DIR=no "INSTALL=install --strip-program=true" DESTDIR=/build/reproducible-path/sslh-1.20/debian/sslh/usr PREFIX=/ install make[2]: Entering directory '/build/reproducible-path/sslh-1.20' Makefile:66: warning: ignoring prerequisites on suffix rule definition mkdir -p /build/reproducible-path/sslh-1.20/debian/sslh/usr///sbin @@ -3822,12 +3812,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/2701157/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/2701157/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/2631684 and its subdirectories -I: Current time: Sun Aug 24 12:26:25 -12 2025 -I: pbuilder-time-stamp: 1756081585 +I: removing directory /srv/workspace/pbuilder/2701157 and its subdirectories +I: Current time: Tue Jul 23 08:07:27 +14 2024 +I: pbuilder-time-stamp: 1721671647