View Issue Details
ID | Project | Category | View Status | Date Submitted | Last Update |
---|---|---|---|---|---|
0005794 | GNUnet | gnunet-setup | public | 2019-07-06 17:02 | 2019-07-24 20:42 |
Reporter | xrs | Assigned To | lurchi | ||
Priority | high | Severity | major | Reproducibility | always |
Status | closed | Resolution | fixed | ||
Platform | x86_64 | OS | Archlinux | OS Version | edge |
Product Version | Git master | ||||
Target Version | 0.11.6 | Fixed in Version | 0.11.6 | ||
Summary | 0005794: multi user setup not working properly | ||||
Description | When using some of the CLI tools under a normal user they hang. E.g.: > gnunet-identity -d or > gnunet-arm -I One reason could be that no runtime was created for the user. There exists the gnunet-gnunet-runtime and gnunet-system-runtime under /tmp. Lurchi seems to have similar problems and concluded that the multi user setup did not work for him. Another example, maybe different problem, but this works under single user setup: > gnunet-publish text.txt Error publishing: Can not index file `/home/xrs/text.txt': . . | ||||
Steps To Reproduce | Install everything as described in Chapter 4.1 to 4.7.1. in https://docs.gnunet.org/#Installing-GNUnet. There are two configs: - /etc/gnunet.conf - ~/.config/gnunet.conf Run gnunet instance under user gnunet. Run CLI tools under normal user. | ||||
Additional Information | Adding configs and some logs. | ||||
Tags | No tags attached. | ||||
Attached Files | gnunet-idedentity.log (32,375 bytes)
Jul 06 16:21:32-930718 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/consensus.conf' Jul 06 16:21:32-931106 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/consensus.conf' Jul 06 16:21:32-931303 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/scalarproduct.conf' Jul 06 16:21:32-931468 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/scalarproduct.conf' Jul 06 16:21:32-931680 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/nat-auto.conf' Jul 06 16:21:32-931838 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/nat-auto.conf' Jul 06 16:21:32-932017 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/set.conf' Jul 06 16:21:32-932174 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/set.conf' Jul 06 16:21:32-932328 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/auction.conf' Jul 06 16:21:32-932482 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/auction.conf' Jul 06 16:21:32-932596 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/ats.conf' Jul 06 16:21:32-932773 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/ats.conf' Jul 06 16:21:32-933253 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/topology.conf' Jul 06 16:21:32-933412 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/topology.conf' Jul 06 16:21:32-933555 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/zonemaster.conf' Jul 06 16:21:32-933943 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/zonemaster.conf' Jul 06 16:21:32-934219 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/template.conf' Jul 06 16:21:32-934380 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/template.conf' Jul 06 16:21:32-934569 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/exit.conf' Jul 06 16:21:32-934749 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/exit.conf' Jul 06 16:21:32-935024 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/credential.conf' Jul 06 16:21:32-935103 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/credential.conf' Jul 06 16:21:32-935165 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/secretsharing.conf' Jul 06 16:21:32-935264 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/secretsharing.conf' Jul 06 16:21:32-935373 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/gns.conf' Jul 06 16:21:32-935456 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/gns.conf' Jul 06 16:21:32-935619 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/communicator-unix.conf' Jul 06 16:21:32-935699 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/communicator-unix.conf' Jul 06 16:21:32-935751 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/rest.conf' Jul 06 16:21:32-935828 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/rest.conf' Jul 06 16:21:32-935907 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/dht.conf' Jul 06 16:21:32-935987 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/dht.conf' Jul 06 16:21:32-936130 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/namecache.conf' Jul 06 16:21:32-936212 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/namecache.conf' Jul 06 16:21:32-936337 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/transport.conf' Jul 06 16:21:32-936473 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/transport.conf' Jul 06 16:21:32-936962 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/namestore.conf' Jul 06 16:21:32-937046 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/namestore.conf' Jul 06 16:21:32-937217 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/revocation.conf' Jul 06 16:21:32-937297 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/revocation.conf' Jul 06 16:21:32-937394 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/testbed.conf' Jul 06 16:21:32-937486 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/testbed.conf' Jul 06 16:21:32-937769 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/cadet.conf' Jul 06 16:21:32-937852 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/cadet.conf' Jul 06 16:21:32-938005 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/arm.conf' Jul 06 16:21:32-938088 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/arm.conf' Jul 06 16:21:32-938233 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/util.conf' Jul 06 16:21:32-938317 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/util.conf' Jul 06 16:21:32-938507 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/rps.conf' Jul 06 16:21:32-938589 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/rps.conf' Jul 06 16:21:32-938720 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/testbed-logger.conf' Jul 06 16:21:32-938814 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/testbed-logger.conf' Jul 06 16:21:32-939115 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/fs.conf' Jul 06 16:21:32-939199 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/fs.conf' Jul 06 16:21:32-939400 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/reclaim.conf' Jul 06 16:21:32-939480 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/reclaim.conf' Jul 06 16:21:32-939590 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/datastore.conf' Jul 06 16:21:32-939670 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/datastore.conf' Jul 06 16:21:32-939812 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/resolver.conf' Jul 06 16:21:32-939892 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/resolver.conf' Jul 06 16:21:32-939981 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/vpn.conf' Jul 06 16:21:32-940059 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/vpn.conf' Jul 06 16:21:32-940163 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/nat.conf' Jul 06 16:21:32-940249 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/nat.conf' Jul 06 16:21:32-940384 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/datacache.conf' Jul 06 16:21:32-940462 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/datacache.conf' Jul 06 16:21:32-940517 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/core.conf' Jul 06 16:21:32-940596 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/core.conf' Jul 06 16:21:32-940692 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/testing.conf' Jul 06 16:21:32-940771 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/testing.conf' Jul 06 16:21:32-940864 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/identity.conf' Jul 06 16:21:32-940943 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/identity.conf' Jul 06 16:21:32-941040 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/pt.conf' Jul 06 16:21:32-941117 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/pt.conf' Jul 06 16:21:32-941191 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/nse.conf' Jul 06 16:21:32-941279 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/nse.conf' Jul 06 16:21:32-941410 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/peerinfo.conf' Jul 06 16:21:32-941491 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/peerinfo.conf' Jul 06 16:21:32-941611 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/statistics.conf' Jul 06 16:21:32-941690 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/statistics.conf' Jul 06 16:21:32-941785 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/regex.conf' Jul 06 16:21:32-941863 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/regex.conf' Jul 06 16:21:32-941937 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/peerstore.conf' Jul 06 16:21:32-942017 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/peerstore.conf' Jul 06 16:21:32-942107 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/hostlist.conf' Jul 06 16:21:32-942195 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/hostlist.conf' Jul 06 16:21:32-942311 util-15468 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/dns.conf' Jul 06 16:21:32-942392 util-15468 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/dns.conf' Jul 06 16:21:32-942568 util-15468 DEBUG Asked to parse config file `/home/xrs/.config/gnunet.conf' Jul 06 16:21:32-942647 util-15468 DEBUG Deserializing contents of file `/home/xrs/.config/gnunet.conf' Jul 06 16:21:32-942779 util-scheduler-15468 DEBUG Registering signal handlers Jul 06 16:21:32-942854 util-scheduler-15468 DEBUG Adding task 0xa6f868 Jul 06 16:21:32-942917 util-scheduler-15468 DEBUG Adding continuation task 0xa6fa58 Jul 06 16:21:32-942975 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:32 2019 Jul 06 16:21:32-943036 util-scheduler-15468 DEBUG Running task 0xa6f868 Jul 06 16:21:32-943079 util-os-priority-15468 DEBUG Not installing a handler because $GNUNET_OS_CONTROL_PIPE is empty Jul 06 16:21:32-943127 util-scheduler-15468 DEBUG destroying task 0xa6f868 Jul 06 16:21:32-943165 util-scheduler-15468 DEBUG Running task 0xa6fa58 Jul 06 16:21:32-943228 util-speedup-15468 DEBUG Speed up disabled Jul 06 16:21:32-943270 util-scheduler-15468 DEBUG Adding shutdown task 0xa6fbe8 Jul 06 16:21:32-944534 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:32-944591 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:32-944634 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-944676 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:32-944716 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:32-944753 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:32-944792 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:32-944828 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:32-944883 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-944923 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:32-944962 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:32-945031 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:32-945087 util-scheduler-15468 DEBUG Adding task 0xa84b28 Jul 06 16:21:32-945140 arm-api-15468 DEBUG Sending TEST message to ARM Jul 06 16:21:32-945184 util-mq-15468 DEBUG sending message of type 15, queue empty (MQ: 0xa84b98) Jul 06 16:21:32-945222 util-client-15468 DEBUG message of type 15 waiting for socket Jul 06 16:21:32-945263 util-scheduler-15468 DEBUG Adding task 0xa84c30 Jul 06 16:21:32-945303 util-scheduler-15468 DEBUG Adding shutdown task 0xa84ca0 Jul 06 16:21:32-945340 util-scheduler-15468 DEBUG destroying task 0xa6fa58 Jul 06 16:21:32-945394 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:32 2019 Jul 06 16:21:32-945437 util-scheduler-15468 DEBUG Running task 0xa84c30 Jul 06 16:21:32-945477 gnunet-arm-15468 DEBUG Running requested actions Jul 06 16:21:32-945511 gnunet-arm-15468 DEBUG Initialization action Jul 06 16:21:32-945550 arm-api-15468 DEBUG Starting service `identity' Jul 06 16:21:32-945603 util-scheduler-15468 DEBUG destroying task 0xa84c30 Jul 06 16:21:32-945642 util-scheduler-15468 DEBUG Running task 0xa84b28 Jul 06 16:21:32-945683 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:32-945721 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:32-945763 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-945803 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:32-945843 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:32-945880 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:32-945920 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:32-945956 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:32-945998 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-946037 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:32-946077 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:32-946114 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:32-946293 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 2 ms. Jul 06 16:21:32-946335 util-scheduler-15468 DEBUG Adding task 0xa84e28 Jul 06 16:21:32-946371 util-scheduler-15468 DEBUG destroying task 0xa84b28 Jul 06 16:21:32-946424 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:32 2019 Jul 06 16:21:32-948413 util-scheduler-15468 DEBUG Running task 0xa84e28 Jul 06 16:21:32-948456 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:32-948495 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:32-948538 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-948577 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:32-948616 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:32-948654 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:32-948694 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:32-948729 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:32-948771 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-948809 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:32-948848 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:32-948885 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:32-948990 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 4 ms. Jul 06 16:21:32-949056 util-scheduler-15468 DEBUG Adding task 0xa84ee0 Jul 06 16:21:32-949093 util-scheduler-15468 DEBUG destroying task 0xa84e28 Jul 06 16:21:32-949147 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:32 2019 Jul 06 16:21:32-953121 util-scheduler-15468 DEBUG Running task 0xa84ee0 Jul 06 16:21:32-953166 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:32-953204 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:32-953247 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-953287 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:32-953326 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:32-953364 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:32-953403 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:32-953438 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:32-953480 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-953518 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:32-953607 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:32-953655 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:32-953763 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 8 ms. Jul 06 16:21:32-953815 util-scheduler-15468 DEBUG Adding task 0xa84f98 Jul 06 16:21:32-953853 util-scheduler-15468 DEBUG destroying task 0xa84ee0 Jul 06 16:21:32-953906 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:32 2019 Jul 06 16:21:32-961901 util-scheduler-15468 DEBUG Running task 0xa84f98 Jul 06 16:21:32-961944 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:32-961982 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:32-962026 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-962065 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:32-962105 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:32-962143 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:32-962182 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:32-962218 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:32-962259 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-962298 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:32-962337 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:32-962375 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:32-962478 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 16 ms. Jul 06 16:21:32-962519 util-scheduler-15468 DEBUG Adding task 0xa85050 Jul 06 16:21:32-962556 util-scheduler-15468 DEBUG destroying task 0xa84f98 Jul 06 16:21:32-962608 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:32 2019 Jul 06 16:21:32-978587 util-scheduler-15468 DEBUG Running task 0xa85050 Jul 06 16:21:32-978658 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:32-978698 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:32-978743 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-978782 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:32-978822 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:32-978860 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:32-978937 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:32-978974 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:32-979017 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:32-979056 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:32-979095 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:32-979132 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:32-979256 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 32 ms. Jul 06 16:21:32-979299 util-scheduler-15468 DEBUG Adding task 0xa850c0 Jul 06 16:21:32-979336 util-scheduler-15468 DEBUG destroying task 0xa85050 Jul 06 16:21:32-979391 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:33 2019 Jul 06 16:21:33-011432 util-scheduler-15468 DEBUG Running task 0xa850c0 Jul 06 16:21:33-011714 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:33-011816 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:33-011913 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:33-012016 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:33-012123 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:33-012204 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:33-012292 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:33-012368 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:33-012460 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:33-012538 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:33-012619 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:33-012695 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:33-012982 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 64 ms. Jul 06 16:21:33-013070 util-scheduler-15468 DEBUG Adding task 0xa85130 Jul 06 16:21:33-013144 util-scheduler-15468 DEBUG destroying task 0xa850c0 Jul 06 16:21:33-013254 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:33 2019 Jul 06 16:21:33-077195 util-scheduler-15468 DEBUG Running task 0xa85130 Jul 06 16:21:33-077447 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:33-077536 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:33-077627 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:33-077707 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:33-077789 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:33-077865 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:33-077944 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:33-078016 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:33-078105 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:33-078182 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:33-078261 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:33-078335 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:33-078617 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 128 ms. Jul 06 16:21:33-078703 util-scheduler-15468 DEBUG Adding task 0xa851a0 Jul 06 16:21:33-078778 util-scheduler-15468 DEBUG destroying task 0xa85130 Jul 06 16:21:33-078887 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:33 2019 Jul 06 16:21:33-206894 util-scheduler-15468 DEBUG Running task 0xa851a0 Jul 06 16:21:33-207142 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:33-207229 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:33-207316 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:33-207396 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:33-207477 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:33-207552 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:33-207631 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:33-207704 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:33-207791 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:33-207868 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:33-207946 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:33-208020 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:33-208285 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 256 ms. Jul 06 16:21:33-208370 util-scheduler-15468 DEBUG Adding task 0xa85128 Jul 06 16:21:33-208445 util-scheduler-15468 DEBUG destroying task 0xa851a0 Jul 06 16:21:33-208554 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:33 2019 Jul 06 16:21:33-464664 util-scheduler-15468 DEBUG Running task 0xa85128 Jul 06 16:21:33-464835 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:33-464882 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:33-464928 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:33-464969 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:33-465010 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:33-465048 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:33-465088 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:33-465124 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:33-465170 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:33-465207 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:33-465247 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:33-465284 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:33-465447 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 512 ms. Jul 06 16:21:33-465490 util-scheduler-15468 DEBUG Adding task 0xa851e8 Jul 06 16:21:33-465528 util-scheduler-15468 DEBUG destroying task 0xa85128 Jul 06 16:21:33-465583 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:33 2019 Jul 06 16:21:33-978059 util-scheduler-15468 DEBUG Running task 0xa851e8 Jul 06 16:21:33-978228 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:33-978275 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:33-978321 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:33-978362 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:33-978403 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:33-978441 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:33-978480 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:33-978516 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:33-978561 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:33-978653 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:33-978694 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:33-978731 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:33-978891 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 1024 ms. Jul 06 16:21:33-978934 util-scheduler-15468 DEBUG Adding task 0xa852a0 Jul 06 16:21:33-978972 util-scheduler-15468 DEBUG destroying task 0xa851e8 Jul 06 16:21:33-979027 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:35 2019 Jul 06 16:21:35-003709 util-scheduler-15468 DEBUG Running task 0xa852a0 Jul 06 16:21:35-003928 util-15468 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Jul 06 16:21:35-003983 util-15468 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Jul 06 16:21:35-004037 util-15468 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:35-004083 util-15468 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Jul 06 16:21:35-004129 util-15468 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:21:35-004172 util-15468 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:21:35-004215 util-15468 DEBUG Asked to $-expand /tmp Jul 06 16:21:35-004255 util-15468 DEBUG Doesn't start with $ - not expanding Jul 06 16:21:35-004303 util-15468 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Jul 06 16:21:35-004345 util-15468 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Jul 06 16:21:35-004389 util-15468 DEBUG Asked to $-expand ${USER:-user} Jul 06 16:21:35-004430 util-15468 DEBUG Split into `USER' and `' with default user Jul 06 16:21:35-004598 util-client-15468 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 2048 ms. Jul 06 16:21:35-004647 util-scheduler-15468 DEBUG Adding task 0xa85310 Jul 06 16:21:35-004689 util-scheduler-15468 DEBUG destroying task 0xa852a0 Jul 06 16:21:35-004751 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:37 2019 Jul 06 16:21:36-429661 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:37 2019 Jul 06 16:21:36-429936 util-scheduler-15468 DEBUG Running task 0xa6f8d8 Jul 06 16:21:36-430105 util-scheduler-15468 DEBUG GNUNET_SCHEDULER_shutdown Jul 06 16:21:36-430204 util-scheduler-15468 DEBUG destroying task 0xa6f8d8 Jul 06 16:21:36-430290 util-scheduler-15468 DEBUG scheduler has more tasks ready! Jul 06 16:21:36-430400 util-scheduler-15468 DEBUG select timeout = Sat Jul 06 16:21:36 2019 Jul 06 16:21:36-430493 util-scheduler-15468 DEBUG Running task 0xa6fbe8 Jul 06 16:21:36-430583 util-scheduler-15468 DEBUG destroying task 0xa6fbe8 Jul 06 16:21:36-430665 util-scheduler-15468 DEBUG Running task 0xa84ca0 Jul 06 16:21:36-430767 arm-api-15468 DEBUG Disconnecting from ARM service Jul 06 16:21:36-430858 util-scheduler-15468 DEBUG canceling task 0xa85310 Jul 06 16:21:36-430940 util-scheduler-15468 DEBUG destroying task 0xa85310 Jul 06 16:21:36-431029 util-mq-15468 DEBUG MQ destroy drops message of type 8 Jul 06 16:21:36-431114 util-mq-15468 DEBUG MQ destroy drops current message of type 15 Jul 06 16:21:36-432238 util-scheduler-15468 DEBUG destroying task 0xa84ca0 Jul 06 16:21:36-432321 util-scheduler-15468 DEBUG GNUNET_SCHEDULER_shutdown Jul 06 16:21:36-432399 util-scheduler-15468 DEBUG canceling task 0xa852a0 Jul 06 16:21:36-432480 util-scheduler-15468 DEBUG destroying task 0xa852a0 gnunet-publish.log (54,762 bytes)
Jul 06 16:50:38-705625 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/consensus.conf' Jul 06 16:50:38-705839 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/consensus.conf' Jul 06 16:50:38-705949 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/scalarproduct.conf' Jul 06 16:50:38-706032 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/scalarproduct.conf' Jul 06 16:50:38-706136 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/nat-auto.conf' Jul 06 16:50:38-706216 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/nat-auto.conf' Jul 06 16:50:38-706304 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/set.conf' Jul 06 16:50:38-706382 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/set.conf' Jul 06 16:50:38-706458 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/auction.conf' Jul 06 16:50:38-706543 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/auction.conf' Jul 06 16:50:38-706600 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/ats.conf' Jul 06 16:50:38-706681 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/ats.conf' Jul 06 16:50:38-706918 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/topology.conf' Jul 06 16:50:38-706998 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/topology.conf' Jul 06 16:50:38-707069 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/zonemaster.conf' Jul 06 16:50:38-707150 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/zonemaster.conf' Jul 06 16:50:38-707285 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/template.conf' Jul 06 16:50:38-707366 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/template.conf' Jul 06 16:50:38-707458 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/exit.conf' Jul 06 16:50:38-707559 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/exit.conf' Jul 06 16:50:38-707738 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/credential.conf' Jul 06 16:50:38-707816 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/credential.conf' Jul 06 16:50:38-707879 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/secretsharing.conf' Jul 06 16:50:38-707958 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/secretsharing.conf' Jul 06 16:50:38-708045 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/gns.conf' Jul 06 16:50:38-708127 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/gns.conf' Jul 06 16:50:38-708288 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/communicator-unix.conf' Jul 06 16:50:38-708369 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/communicator-unix.conf' Jul 06 16:50:38-708420 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/rest.conf' Jul 06 16:50:38-708498 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/rest.conf' Jul 06 16:50:38-708577 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/dht.conf' Jul 06 16:50:38-708664 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/dht.conf' Jul 06 16:50:38-708786 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/namecache.conf' Jul 06 16:50:38-708867 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/namecache.conf' Jul 06 16:50:38-708991 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/transport.conf' Jul 06 16:50:38-709117 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/transport.conf' Jul 06 16:50:38-709598 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/namestore.conf' Jul 06 16:50:38-709681 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/namestore.conf' Jul 06 16:50:38-709851 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/revocation.conf' Jul 06 16:50:38-709930 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/revocation.conf' Jul 06 16:50:38-710027 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/testbed.conf' Jul 06 16:50:38-710122 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/testbed.conf' Jul 06 16:50:38-710403 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/cadet.conf' Jul 06 16:50:38-710485 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/cadet.conf' Jul 06 16:50:38-710636 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/arm.conf' Jul 06 16:50:38-710720 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/arm.conf' Jul 06 16:50:38-710863 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/util.conf' Jul 06 16:50:38-710947 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/util.conf' Jul 06 16:50:38-711136 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/rps.conf' Jul 06 16:50:38-711219 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/rps.conf' Jul 06 16:50:38-711349 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/testbed-logger.conf' Jul 06 16:50:38-711442 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/testbed-logger.conf' Jul 06 16:50:38-711742 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/fs.conf' Jul 06 16:50:38-711826 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/fs.conf' Jul 06 16:50:38-712026 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/reclaim.conf' Jul 06 16:50:38-712106 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/reclaim.conf' Jul 06 16:50:38-712215 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/datastore.conf' Jul 06 16:50:38-712295 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/datastore.conf' Jul 06 16:50:38-712437 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/resolver.conf' Jul 06 16:50:38-712516 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/resolver.conf' Jul 06 16:50:38-712604 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/vpn.conf' Jul 06 16:50:38-712683 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/vpn.conf' Jul 06 16:50:38-712785 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/nat.conf' Jul 06 16:50:38-712873 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/nat.conf' Jul 06 16:50:38-713006 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/datacache.conf' Jul 06 16:50:38-713085 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/datacache.conf' Jul 06 16:50:38-713139 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/core.conf' Jul 06 16:50:38-713218 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/core.conf' Jul 06 16:50:38-713314 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/testing.conf' Jul 06 16:50:38-713394 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/testing.conf' Jul 06 16:50:38-713487 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/identity.conf' Jul 06 16:50:38-713662 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/identity.conf' Jul 06 16:50:38-713772 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/pt.conf' Jul 06 16:50:38-713852 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/pt.conf' Jul 06 16:50:38-713925 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/nse.conf' Jul 06 16:50:38-714016 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/nse.conf' Jul 06 16:50:38-714147 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/peerinfo.conf' Jul 06 16:50:38-714229 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/peerinfo.conf' Jul 06 16:50:38-714347 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/statistics.conf' Jul 06 16:50:38-714427 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/statistics.conf' Jul 06 16:50:38-714521 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/regex.conf' Jul 06 16:50:38-714599 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/regex.conf' Jul 06 16:50:38-714673 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/peerstore.conf' Jul 06 16:50:38-714751 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/peerstore.conf' Jul 06 16:50:38-714841 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/hostlist.conf' Jul 06 16:50:38-714930 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/hostlist.conf' Jul 06 16:50:38-715044 util-28552 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/dns.conf' Jul 06 16:50:38-715125 util-28552 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/dns.conf' Jul 06 16:50:38-715291 util-28552 DEBUG Asked to parse config file `/home/xrs/.config/gnunet.conf' Jul 06 16:50:38-715371 util-28552 DEBUG Deserializing contents of file `/home/xrs/.config/gnunet.conf' Jul 06 16:50:38-715533 util-scheduler-28552 DEBUG Registering signal handlers Jul 06 16:50:38-715612 util-scheduler-28552 DEBUG Adding task 0x1074108 Jul 06 16:50:38-715677 util-scheduler-28552 DEBUG Adding continuation task 0x10742f8 Jul 06 16:50:38-715736 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-715798 util-scheduler-28552 DEBUG Running task 0x1074108 Jul 06 16:50:38-715841 util-os-priority-28552 DEBUG Not installing a handler because $GNUNET_OS_CONTROL_PIPE is empty Jul 06 16:50:38-715890 util-scheduler-28552 DEBUG destroying task 0x1074108 Jul 06 16:50:38-715928 util-scheduler-28552 DEBUG Running task 0x10742f8 Jul 06 16:50:38-716000 util-speedup-28552 DEBUG Speed up disabled Jul 06 16:50:38-716042 util-scheduler-28552 DEBUG Adding shutdown task 0x1074478 Jul 06 16:50:38-716099 util-scheduler-28552 DEBUG Adding shutdown task 0x1074560 Jul 06 16:50:38-716202 gnunet-publish-28552 DEBUG Starting to scan directory `/home/xrs/text.txt' Jul 06 16:50:38-716969 gnunet-publish-28552 DEBUG Starting HELPER process `/usr/local/lib//gnunet/libexec/gnunet-helper-fs-publish' Jul 06 16:50:38-717731 util-scheduler-28552 DEBUG destroying task 0x10742f8 Jul 06 16:50:38-717871 util-scheduler-28552 DEBUG select timeout = end of time Jul 06 16:50:38-739294 util-scheduler-28552 DEBUG Running task 0x1074898 Jul 06 16:50:38-739463 gnunet-publish-28552 DEBUG Got 66 bytes from helper `/usr/local/lib//gnunet/libexec/gnunet-helper-fs-publish' Jul 06 16:50:38-739546 util-mst-28552 DEBUG MST receives 66 bytes with 0 bytes already in private buffer Jul 06 16:50:38-739596 util-mst-28552 DEBUG Server-mst has 66 bytes left in inbound buffer Jul 06 16:50:38-739675 util-mst-28552 DEBUG Server-mst has 43 bytes left in inbound buffer Jul 06 16:50:38-739716 util-mst-28552 DEBUG Server-mst has 39 bytes left in inbound buffer Jul 06 16:50:38-740068 util-mst-28552 DEBUG Server-mst has 4 bytes left in inbound buffer Jul 06 16:50:38-740119 util-scheduler-28552 DEBUG Adding task 0x1074b90 Jul 06 16:50:38-740159 util-mst-28552 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:50:38-740198 util-scheduler-28552 DEBUG destroying task 0x1074898 Jul 06 16:50:38-740257 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-740308 util-scheduler-28552 DEBUG Running task 0x1074b90 Jul 06 16:50:38-740354 util-scheduler-28552 DEBUG canceling task 0x1074908 Jul 06 16:50:38-740392 util-scheduler-28552 DEBUG destroying task 0x1074908 Jul 06 16:50:38-740433 util-os-priority-28552 DEBUG Sending signal 15 to pid: 28553 via system call Jul 06 16:50:38-740588 util-mst-28552 DEBUG MST receives 0 bytes with 0 bytes already in private buffer Jul 06 16:50:38-740629 util-mst-28552 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:50:38-740805 datastore-api-28552 DEBUG Establishing DATASTORE connection! Jul 06 16:50:38-740876 util-28552 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-datastore.sock Jul 06 16:50:38-740916 util-28552 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-datastore.sock' with default (null) Jul 06 16:50:38-740959 util-28552 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:50:38-740998 util-28552 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:50:38-741038 util-28552 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:50:38-741076 util-28552 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:50:38-741114 util-28552 DEBUG Asked to $-expand /tmp Jul 06 16:50:38-741150 util-28552 DEBUG Doesn't start with $ - not expanding Jul 06 16:50:38-741210 util-scheduler-28552 DEBUG Adding task 0x1074fb8 Jul 06 16:50:38-741259 datastore-api-28552 DEBUG Reconnected to DATASTORE Jul 06 16:50:38-741297 datastore-api-28552 DEBUG Queue empty Jul 06 16:50:38-741353 gnunet-publish-28552 DEBUG Starting publish operation Jul 06 16:50:38-741416 gnunet-publish-28552 INFO Reserving space for 4 entries and 196608 bytes for publication Jul 06 16:50:38-741458 datastore-api-28552 DEBUG Asked to reserve 196608 bytes of data and 4 entries Jul 06 16:50:38-741522 util-28552 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-statistics.sock Jul 06 16:50:38-741562 util-28552 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-statistics.sock' with default (null) Jul 06 16:50:38-741603 util-28552 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:50:38-741642 util-28552 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:50:38-741682 util-28552 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:50:38-741719 util-28552 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:50:38-741757 util-28552 DEBUG Asked to $-expand /tmp Jul 06 16:50:38-741793 util-28552 DEBUG Doesn't start with $ - not expanding Jul 06 16:50:38-741842 util-scheduler-28552 DEBUG Adding task 0x1075288 Jul 06 16:50:38-741899 util-mq-28552 DEBUG sending message of type 168, queue empty (MQ: 0x1074848) Jul 06 16:50:38-741938 util-client-28552 DEBUG message of type 168 waiting for socket Jul 06 16:50:38-741979 util-scheduler-28552 DEBUG Adding task 0x10753b0 Jul 06 16:50:38-742017 util-mq-28552 DEBUG sending message of type 92, queue empty (MQ: 0x1073550) Jul 06 16:50:38-742054 util-client-28552 DEBUG message of type 92 waiting for socket Jul 06 16:50:38-742091 util-scheduler-28552 DEBUG destroying task 0x1074b90 Jul 06 16:50:38-742146 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-742189 util-scheduler-28552 DEBUG Running task 0x1075288 Jul 06 16:50:38-742229 util-28552 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-statistics.sock Jul 06 16:50:38-742267 util-28552 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-statistics.sock' with default (null) Jul 06 16:50:38-742307 util-28552 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:50:38-742382 util-28552 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:50:38-742422 util-28552 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:50:38-742460 util-28552 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:50:38-742498 util-28552 DEBUG Asked to $-expand /tmp Jul 06 16:50:38-742534 util-28552 DEBUG Doesn't start with $ - not expanding Jul 06 16:50:38-742687 util-client-28552 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-statistics.sock'! Jul 06 16:50:38-742743 util-scheduler-28552 DEBUG destroying task 0x1075288 Jul 06 16:50:38-742782 util-scheduler-28552 DEBUG Running task 0x1074fb8 Jul 06 16:50:38-742824 util-28552 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-datastore.sock Jul 06 16:50:38-742862 util-28552 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-datastore.sock' with default (null) Jul 06 16:50:38-742903 util-28552 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:50:38-742941 util-28552 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:50:38-742980 util-28552 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:50:38-743017 util-28552 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:50:38-743054 util-28552 DEBUG Asked to $-expand /tmp Jul 06 16:50:38-743090 util-28552 DEBUG Doesn't start with $ - not expanding Jul 06 16:50:38-743182 util-client-28552 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-datastore.sock'! Jul 06 16:50:38-743225 util-scheduler-28552 DEBUG destroying task 0x1074fb8 Jul 06 16:50:38-743280 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:51:38 2019 Jul 06 16:50:38-743325 util-scheduler-28552 DEBUG Running task 0x10754d8 Jul 06 16:50:38-743365 util-client-28552 DEBUG message of type 168 trying to send with socket 0x1075208 (MQ: 0x1074848 Jul 06 16:50:38-743430 util-client-28552 DEBUG sending message of type 168 successful Jul 06 16:50:38-743474 util-scheduler-28552 DEBUG Adding task 0x1074fb8 Jul 06 16:50:38-743514 util-scheduler-28552 DEBUG destroying task 0x10754d8 Jul 06 16:50:38-743552 util-scheduler-28552 DEBUG Running task 0x10755f0 Jul 06 16:50:38-743700 util-client-28552 DEBUG message of type 92 trying to send with socket 0x1075440 (MQ: 0x1073550 Jul 06 16:50:38-743753 util-client-28552 DEBUG sending message of type 92 successful Jul 06 16:50:38-743793 util-scheduler-28552 DEBUG Adding task 0x10754d8 Jul 06 16:50:38-743831 util-scheduler-28552 DEBUG destroying task 0x10755f0 Jul 06 16:50:38-743885 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-743927 util-scheduler-28552 DEBUG Running task 0x10754d8 Jul 06 16:50:38-743964 util-scheduler-28552 DEBUG destroying task 0x10754d8 Jul 06 16:50:38-744001 util-scheduler-28552 DEBUG Running task 0x1074fb8 Jul 06 16:50:38-744037 util-scheduler-28552 DEBUG destroying task 0x1074fb8 Jul 06 16:50:38-744074 util-scheduler-28552 DEBUG Running task 0x1075580 Jul 06 16:50:38-744130 util-mst-28552 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Jul 06 16:50:38-744173 util-scheduler-28552 DEBUG destroying task 0x1075580 Jul 06 16:50:38-744226 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:51:38 2019 Jul 06 16:50:38-744269 util-scheduler-28552 DEBUG Running task 0x10755f0 Jul 06 16:50:38-744313 util-mst-28552 DEBUG MST receives 0 bytes with 16 bytes already in private buffer Jul 06 16:50:38-744352 util-client-28552 DEBUG Received message of type 94 and size 16 from datastore Jul 06 16:50:38-744393 util-mq-28552 DEBUG Received message of type 94 and size 16 Jul 06 16:50:38-744435 util-scheduler-28552 DEBUG canceling task 0x10753b0 Jul 06 16:50:38-744472 util-scheduler-28552 DEBUG destroying task 0x10753b0 Jul 06 16:50:38-744512 datastore-api-28552 DEBUG Received status 10/(null) Jul 06 16:50:38-744557 util-mq-28552 DEBUG sending message of type 168, queue empty (MQ: 0x1074848) Jul 06 16:50:38-744643 datastore-api-28552 DEBUG Queue empty Jul 06 16:50:38-744683 gnunet-publish-28552 DEBUG Reservation complete (10)! Jul 06 16:50:38-744726 util-scheduler-28552 DEBUG Adding task 0x10753b0 Jul 06 16:50:38-744764 util-mst-28552 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:50:38-744803 util-scheduler-28552 DEBUG destroying task 0x10755f0 Jul 06 16:50:38-744855 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-744897 util-scheduler-28552 DEBUG Running task 0x1075580 Jul 06 16:50:38-744935 util-client-28552 DEBUG message of type 168 trying to send with socket 0x1075208 (MQ: 0x1074848 Jul 06 16:50:38-744986 util-client-28552 DEBUG sending message of type 168 successful Jul 06 16:50:38-745026 util-scheduler-28552 DEBUG Adding task 0x10755f0 Jul 06 16:50:38-745064 util-scheduler-28552 DEBUG destroying task 0x1075580 Jul 06 16:50:38-745101 util-scheduler-28552 DEBUG scheduler has more tasks ready! Jul 06 16:50:38-745150 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-745192 util-scheduler-28552 DEBUG Running task 0x10755f0 Jul 06 16:50:38-745228 util-scheduler-28552 DEBUG destroying task 0x10755f0 Jul 06 16:50:38-745265 util-scheduler-28552 DEBUG scheduler has more tasks ready! Jul 06 16:50:38-745314 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-745353 util-scheduler-28552 DEBUG Running task 0x10753b0 Jul 06 16:50:38-745561 util-scheduler-28552 DEBUG Adding task 0x1074ed8 Jul 06 16:50:38-745600 util-scheduler-28552 DEBUG destroying task 0x10753b0 Jul 06 16:50:38-745653 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-745694 util-scheduler-28552 DEBUG Running task 0x1074ed8 Jul 06 16:50:38-745775 gnunet-publish-28552 DEBUG Hash of indexed file `/home/xrs/text.txt' is `SY1Y2DBY' Jul 06 16:50:38-745826 util-28552 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-fs.sock Jul 06 16:50:38-745865 util-28552 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-fs.sock' with default (null) Jul 06 16:50:38-745907 util-28552 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:50:38-745947 util-28552 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:50:38-745987 util-28552 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:50:38-746023 util-28552 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:50:38-746062 util-28552 DEBUG Asked to $-expand /tmp Jul 06 16:50:38-746098 util-28552 DEBUG Doesn't start with $ - not expanding Jul 06 16:50:38-746151 util-scheduler-28552 DEBUG Adding task 0x1075b10 Jul 06 16:50:38-746231 util-mq-28552 DEBUG sending message of type 128, queue empty (MQ: 0x1075b80) Jul 06 16:50:38-746269 util-client-28552 DEBUG message of type 128 waiting for socket Jul 06 16:50:38-746589 util-scheduler-28552 DEBUG destroying task 0x1074ed8 Jul 06 16:50:38-746648 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-746691 util-scheduler-28552 DEBUG Running task 0x1075b10 Jul 06 16:50:38-746733 util-28552 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-fs.sock Jul 06 16:50:38-746772 util-28552 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-fs.sock' with default (null) Jul 06 16:50:38-746814 util-28552 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:50:38-746853 util-28552 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:50:38-746892 util-28552 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:50:38-746929 util-28552 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:50:38-746968 util-28552 DEBUG Asked to $-expand /tmp Jul 06 16:50:38-747004 util-28552 DEBUG Doesn't start with $ - not expanding Jul 06 16:50:38-747143 util-client-28552 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-fs.sock'! Jul 06 16:50:38-747190 util-scheduler-28552 DEBUG destroying task 0x1075b10 Jul 06 16:50:38-747231 util-scheduler-28552 DEBUG select timeout = end of time Jul 06 16:50:38-747322 util-scheduler-28552 DEBUG Running task 0x1075758 Jul 06 16:50:38-747362 util-client-28552 DEBUG message of type 128 trying to send with socket 0x1075198 (MQ: 0x1075b80 Jul 06 16:50:38-747419 util-client-28552 DEBUG sending message of type 128 successful Jul 06 16:50:38-747460 util-scheduler-28552 DEBUG Adding task 0x10757c8 Jul 06 16:50:38-747501 util-scheduler-28552 DEBUG destroying task 0x1075758 Jul 06 16:50:38-747563 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-747605 util-scheduler-28552 DEBUG Running task 0x10757c8 Jul 06 16:50:38-747647 util-scheduler-28552 DEBUG destroying task 0x10757c8 Jul 06 16:50:38-747689 util-scheduler-28552 DEBUG select timeout = end of time Jul 06 16:50:38-747733 util-scheduler-28552 DEBUG Running task 0x10756e8 Jul 06 16:50:38-747778 util-mst-28552 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Jul 06 16:50:38-747817 util-client-28552 DEBUG Received message of type 130 and size 4 from fs Jul 06 16:50:38-747854 util-mq-28552 DEBUG Received message of type 130 and size 4 Jul 06 16:50:38-747946 util-scheduler-28552 DEBUG GNUNET_SCHEDULER_shutdown Jul 06 16:50:38-747984 util-scheduler-28552 DEBUG canceling task 0x1074178 Jul 06 16:50:38-748021 util-scheduler-28552 DEBUG destroying task 0x1074178 Jul 06 16:50:38-748062 util-client-28552 DEBUG destroying socket: 0x1075198 Jul 06 16:50:38-748130 util-scheduler-28552 DEBUG destroying task 0x10756e8 Jul 06 16:50:38-748170 util-scheduler-28552 DEBUG scheduler has more tasks ready! Jul 06 16:50:38-748220 util-scheduler-28552 DEBUG select timeout = Sat Jul 06 16:50:38 2019 Jul 06 16:50:38-748261 util-scheduler-28552 DEBUG Running task 0x1074478 Jul 06 16:50:38-748301 util-scheduler-28552 DEBUG destroying task 0x1074478 Jul 06 16:50:38-748338 util-scheduler-28552 DEBUG Running task 0x1074560 Jul 06 16:50:38-748377 gnunet-publish-28552 DEBUG Publish stop called Jul 06 16:50:38-748418 gnunet-publish-28552 DEBUG Cleaning up publish context (done!) Jul 06 16:50:38-748469 datastore-api-28552 DEBUG Datastore disconnect Jul 06 16:50:38-748509 util-scheduler-28552 DEBUG canceling task 0x1075678 Jul 06 16:50:38-748546 util-scheduler-28552 DEBUG destroying task 0x1075678 Jul 06 16:50:38-748583 util-client-28552 DEBUG destroying socket: 0x1075440 Jul 06 16:50:38-748652 gnunet-publish-28552 DEBUG Cleaning all up Jul 06 16:50:38-748692 util-scheduler-28552 DEBUG canceling task 0x1075468 Jul 06 16:50:38-748730 util-scheduler-28552 DEBUG destroying task 0x1075468 Jul 06 16:50:38-748767 util-client-28552 DEBUG destroying socket: 0x1075208 Jul 06 16:50:38-748830 util-scheduler-28552 DEBUG destroying task 0x1074560 Jul 06 16:50:38-748870 util-scheduler-28552 DEBUG GNUNET_SCHEDULER_shutdown Jul 06 16:52:20-039716 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/consensus.conf' Jul 06 16:52:20-039969 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/consensus.conf' Jul 06 16:52:20-040094 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/scalarproduct.conf' Jul 06 16:52:20-040181 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/scalarproduct.conf' Jul 06 16:52:20-040288 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/nat-auto.conf' Jul 06 16:52:20-040372 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/nat-auto.conf' Jul 06 16:52:20-040465 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/set.conf' Jul 06 16:52:20-040547 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/set.conf' Jul 06 16:52:20-040627 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/auction.conf' Jul 06 16:52:20-040715 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/auction.conf' Jul 06 16:52:20-040775 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/ats.conf' Jul 06 16:52:20-040898 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/ats.conf' Jul 06 16:52:20-041137 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/topology.conf' Jul 06 16:52:20-041218 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/topology.conf' Jul 06 16:52:20-041290 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/zonemaster.conf' Jul 06 16:52:20-041371 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/zonemaster.conf' Jul 06 16:52:20-041508 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/template.conf' Jul 06 16:52:20-041589 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/template.conf' Jul 06 16:52:20-041681 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/exit.conf' Jul 06 16:52:20-041783 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/exit.conf' Jul 06 16:52:20-041962 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/credential.conf' Jul 06 16:52:20-042042 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/credential.conf' Jul 06 16:52:20-042105 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/secretsharing.conf' Jul 06 16:52:20-042185 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/secretsharing.conf' Jul 06 16:52:20-042272 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/gns.conf' Jul 06 16:52:20-042355 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/gns.conf' Jul 06 16:52:20-042518 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/communicator-unix.conf' Jul 06 16:52:20-042599 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/communicator-unix.conf' Jul 06 16:52:20-042651 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/rest.conf' Jul 06 16:52:20-042729 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/rest.conf' Jul 06 16:52:20-042809 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/dht.conf' Jul 06 16:52:20-042897 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/dht.conf' Jul 06 16:52:20-043020 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/namecache.conf' Jul 06 16:52:20-043101 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/namecache.conf' Jul 06 16:52:20-043227 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/transport.conf' Jul 06 16:52:20-043322 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/transport.conf' Jul 06 16:52:20-043872 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/namestore.conf' Jul 06 16:52:20-043966 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/namestore.conf' Jul 06 16:52:20-044138 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/revocation.conf' Jul 06 16:52:20-044219 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/revocation.conf' Jul 06 16:52:20-044317 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/testbed.conf' Jul 06 16:52:20-044409 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/testbed.conf' Jul 06 16:52:20-044692 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/cadet.conf' Jul 06 16:52:20-044774 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/cadet.conf' Jul 06 16:52:20-044928 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/arm.conf' Jul 06 16:52:20-045011 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/arm.conf' Jul 06 16:52:20-045186 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/util.conf' Jul 06 16:52:20-045271 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/util.conf' Jul 06 16:52:20-045462 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/rps.conf' Jul 06 16:52:20-045546 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/rps.conf' Jul 06 16:52:20-045677 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/testbed-logger.conf' Jul 06 16:52:20-045772 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/testbed-logger.conf' Jul 06 16:52:20-046075 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/fs.conf' Jul 06 16:52:20-046159 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/fs.conf' Jul 06 16:52:20-046361 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/reclaim.conf' Jul 06 16:52:20-046442 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/reclaim.conf' Jul 06 16:52:20-046552 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/datastore.conf' Jul 06 16:52:20-046633 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/datastore.conf' Jul 06 16:52:20-046775 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/resolver.conf' Jul 06 16:52:20-046856 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/resolver.conf' Jul 06 16:52:20-046947 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/vpn.conf' Jul 06 16:52:20-047025 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/vpn.conf' Jul 06 16:52:20-047129 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/nat.conf' Jul 06 16:52:20-047218 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/nat.conf' Jul 06 16:52:20-047353 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/datacache.conf' Jul 06 16:52:20-047432 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/datacache.conf' Jul 06 16:52:20-047486 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/core.conf' Jul 06 16:52:20-047567 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/core.conf' Jul 06 16:52:20-047663 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/testing.conf' Jul 06 16:52:20-047742 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/testing.conf' Jul 06 16:52:20-047815 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/identity.conf' Jul 06 16:52:20-047893 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/identity.conf' Jul 06 16:52:20-047990 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/pt.conf' Jul 06 16:52:20-048069 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/pt.conf' Jul 06 16:52:20-048143 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/nse.conf' Jul 06 16:52:20-048231 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/nse.conf' Jul 06 16:52:20-048362 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/peerinfo.conf' Jul 06 16:52:20-048445 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/peerinfo.conf' Jul 06 16:52:20-048566 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/statistics.conf' Jul 06 16:52:20-048646 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/statistics.conf' Jul 06 16:52:20-048741 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/regex.conf' Jul 06 16:52:20-048841 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/regex.conf' Jul 06 16:52:20-048915 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/peerstore.conf' Jul 06 16:52:20-048994 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/peerstore.conf' Jul 06 16:52:20-049084 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/hostlist.conf' Jul 06 16:52:20-049174 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/hostlist.conf' Jul 06 16:52:20-049290 util-29357 DEBUG Asked to parse config file `/usr/local/share/gnunet/config.d/dns.conf' Jul 06 16:52:20-049371 util-29357 DEBUG Deserializing contents of file `/usr/local/share/gnunet/config.d/dns.conf' Jul 06 16:52:20-049537 util-29357 DEBUG Asked to parse config file `/home/xrs/.config/gnunet.conf' Jul 06 16:52:20-049617 util-29357 DEBUG Deserializing contents of file `/home/xrs/.config/gnunet.conf' Jul 06 16:52:20-049783 util-scheduler-29357 DEBUG Registering signal handlers Jul 06 16:52:20-049864 util-scheduler-29357 DEBUG Adding task 0x617108 Jul 06 16:52:20-049930 util-scheduler-29357 DEBUG Adding continuation task 0x6172f8 Jul 06 16:52:20-049990 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-050053 util-scheduler-29357 DEBUG Running task 0x617108 Jul 06 16:52:20-050096 util-os-priority-29357 DEBUG Not installing a handler because $GNUNET_OS_CONTROL_PIPE is empty Jul 06 16:52:20-050145 util-scheduler-29357 DEBUG destroying task 0x617108 Jul 06 16:52:20-050184 util-scheduler-29357 DEBUG Running task 0x6172f8 Jul 06 16:52:20-050251 util-speedup-29357 DEBUG Speed up disabled Jul 06 16:52:20-050293 util-scheduler-29357 DEBUG Adding shutdown task 0x617478 Jul 06 16:52:20-050376 util-scheduler-29357 DEBUG Adding shutdown task 0x617560 Jul 06 16:52:20-050480 gnunet-publish-29357 DEBUG Starting to scan directory `/home/xrs/text.txt' Jul 06 16:52:20-051260 gnunet-publish-29357 DEBUG Starting HELPER process `/usr/local/lib//gnunet/libexec/gnunet-helper-fs-publish' Jul 06 16:52:20-052044 util-scheduler-29357 DEBUG destroying task 0x6172f8 Jul 06 16:52:20-052196 util-scheduler-29357 DEBUG select timeout = end of time Jul 06 16:52:20-073817 util-scheduler-29357 DEBUG Running task 0x617898 Jul 06 16:52:20-073994 gnunet-publish-29357 DEBUG Got 66 bytes from helper `/usr/local/lib//gnunet/libexec/gnunet-helper-fs-publish' Jul 06 16:52:20-074088 util-mst-29357 DEBUG MST receives 66 bytes with 0 bytes already in private buffer Jul 06 16:52:20-074139 util-mst-29357 DEBUG Server-mst has 66 bytes left in inbound buffer Jul 06 16:52:20-074218 util-mst-29357 DEBUG Server-mst has 43 bytes left in inbound buffer Jul 06 16:52:20-074260 util-mst-29357 DEBUG Server-mst has 39 bytes left in inbound buffer Jul 06 16:52:20-074567 util-mst-29357 DEBUG Server-mst has 4 bytes left in inbound buffer Jul 06 16:52:20-074617 util-scheduler-29357 DEBUG Adding task 0x617b90 Jul 06 16:52:20-074656 util-mst-29357 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:52:20-074697 util-scheduler-29357 DEBUG destroying task 0x617898 Jul 06 16:52:20-074754 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-074806 util-scheduler-29357 DEBUG Running task 0x617b90 Jul 06 16:52:20-074854 util-scheduler-29357 DEBUG canceling task 0x617908 Jul 06 16:52:20-074893 util-scheduler-29357 DEBUG destroying task 0x617908 Jul 06 16:52:20-074935 util-os-priority-29357 DEBUG Sending signal 15 to pid: 29358 via system call Jul 06 16:52:20-075094 util-mst-29357 DEBUG MST receives 0 bytes with 0 bytes already in private buffer Jul 06 16:52:20-075136 util-mst-29357 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:52:20-075315 datastore-api-29357 DEBUG Establishing DATASTORE connection! Jul 06 16:52:20-075386 util-29357 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-datastore.sock Jul 06 16:52:20-075427 util-29357 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-datastore.sock' with default (null) Jul 06 16:52:20-075509 util-29357 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:52:20-075551 util-29357 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:52:20-075593 util-29357 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:52:20-075631 util-29357 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:52:20-075672 util-29357 DEBUG Asked to $-expand /tmp Jul 06 16:52:20-075708 util-29357 DEBUG Doesn't start with $ - not expanding Jul 06 16:52:20-075770 util-scheduler-29357 DEBUG Adding task 0x617fb8 Jul 06 16:52:20-075821 datastore-api-29357 DEBUG Reconnected to DATASTORE Jul 06 16:52:20-075859 datastore-api-29357 DEBUG Queue empty Jul 06 16:52:20-075916 gnunet-publish-29357 DEBUG Starting publish operation Jul 06 16:52:20-075980 gnunet-publish-29357 INFO Reserving space for 4 entries and 196608 bytes for publication Jul 06 16:52:20-076023 datastore-api-29357 DEBUG Asked to reserve 196608 bytes of data and 4 entries Jul 06 16:52:20-076088 util-29357 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-statistics.sock Jul 06 16:52:20-076128 util-29357 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-statistics.sock' with default (null) Jul 06 16:52:20-076169 util-29357 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:52:20-076208 util-29357 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:52:20-076247 util-29357 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:52:20-076285 util-29357 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:52:20-076324 util-29357 DEBUG Asked to $-expand /tmp Jul 06 16:52:20-076360 util-29357 DEBUG Doesn't start with $ - not expanding Jul 06 16:52:20-076409 util-scheduler-29357 DEBUG Adding task 0x618288 Jul 06 16:52:20-076467 util-mq-29357 DEBUG sending message of type 168, queue empty (MQ: 0x617848) Jul 06 16:52:20-076506 util-client-29357 DEBUG message of type 168 waiting for socket Jul 06 16:52:20-076548 util-scheduler-29357 DEBUG Adding task 0x6183b0 Jul 06 16:52:20-076587 util-mq-29357 DEBUG sending message of type 92, queue empty (MQ: 0x616540) Jul 06 16:52:20-076624 util-client-29357 DEBUG message of type 92 waiting for socket Jul 06 16:52:20-076662 util-scheduler-29357 DEBUG destroying task 0x617b90 Jul 06 16:52:20-076718 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-076763 util-scheduler-29357 DEBUG Running task 0x618288 Jul 06 16:52:20-076804 util-29357 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-statistics.sock Jul 06 16:52:20-076842 util-29357 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-statistics.sock' with default (null) Jul 06 16:52:20-076884 util-29357 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:52:20-076923 util-29357 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:52:20-076962 util-29357 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:52:20-077000 util-29357 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:52:20-077039 util-29357 DEBUG Asked to $-expand /tmp Jul 06 16:52:20-077075 util-29357 DEBUG Doesn't start with $ - not expanding Jul 06 16:52:20-077226 util-client-29357 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-statistics.sock'! Jul 06 16:52:20-077282 util-scheduler-29357 DEBUG destroying task 0x618288 Jul 06 16:52:20-077322 util-scheduler-29357 DEBUG Running task 0x617fb8 Jul 06 16:52:20-077363 util-29357 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-datastore.sock Jul 06 16:52:20-077402 util-29357 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-datastore.sock' with default (null) Jul 06 16:52:20-077443 util-29357 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:52:20-077482 util-29357 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:52:20-077522 util-29357 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:52:20-077592 util-29357 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:52:20-077632 util-29357 DEBUG Asked to $-expand /tmp Jul 06 16:52:20-077669 util-29357 DEBUG Doesn't start with $ - not expanding Jul 06 16:52:20-077762 util-client-29357 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-datastore.sock'! Jul 06 16:52:20-077807 util-scheduler-29357 DEBUG destroying task 0x617fb8 Jul 06 16:52:20-077862 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:53:20 2019 Jul 06 16:52:20-077907 util-scheduler-29357 DEBUG Running task 0x6184d8 Jul 06 16:52:20-077948 util-client-29357 DEBUG message of type 168 trying to send with socket 0x618208 (MQ: 0x617848 Jul 06 16:52:20-078017 util-client-29357 DEBUG sending message of type 168 successful Jul 06 16:52:20-078064 util-scheduler-29357 DEBUG Adding task 0x617fb8 Jul 06 16:52:20-078104 util-scheduler-29357 DEBUG destroying task 0x6184d8 Jul 06 16:52:20-078142 util-scheduler-29357 DEBUG Running task 0x6185f0 Jul 06 16:52:20-078181 util-client-29357 DEBUG message of type 92 trying to send with socket 0x618440 (MQ: 0x616540 Jul 06 16:52:20-078231 util-client-29357 DEBUG sending message of type 92 successful Jul 06 16:52:20-078270 util-scheduler-29357 DEBUG Adding task 0x6184d8 Jul 06 16:52:20-078309 util-scheduler-29357 DEBUG destroying task 0x6185f0 Jul 06 16:52:20-078362 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-078404 util-scheduler-29357 DEBUG Running task 0x6184d8 Jul 06 16:52:20-078442 util-scheduler-29357 DEBUG destroying task 0x6184d8 Jul 06 16:52:20-078479 util-scheduler-29357 DEBUG Running task 0x617fb8 Jul 06 16:52:20-078515 util-scheduler-29357 DEBUG destroying task 0x617fb8 Jul 06 16:52:20-078553 util-scheduler-29357 DEBUG Running task 0x618580 Jul 06 16:52:20-078603 util-mst-29357 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Jul 06 16:52:20-078645 util-scheduler-29357 DEBUG destroying task 0x618580 Jul 06 16:52:20-078699 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:53:20 2019 Jul 06 16:52:20-078743 util-scheduler-29357 DEBUG Running task 0x6185f0 Jul 06 16:52:20-078787 util-mst-29357 DEBUG MST receives 0 bytes with 16 bytes already in private buffer Jul 06 16:52:20-078826 util-client-29357 DEBUG Received message of type 94 and size 16 from datastore Jul 06 16:52:20-078868 util-mq-29357 DEBUG Received message of type 94 and size 16 Jul 06 16:52:20-078910 util-scheduler-29357 DEBUG canceling task 0x6183b0 Jul 06 16:52:20-078949 util-scheduler-29357 DEBUG destroying task 0x6183b0 Jul 06 16:52:20-078990 datastore-api-29357 DEBUG Received status 12/(null) Jul 06 16:52:20-079034 util-mq-29357 DEBUG sending message of type 168, queue empty (MQ: 0x617848) Jul 06 16:52:20-079078 datastore-api-29357 DEBUG Queue empty Jul 06 16:52:20-079117 gnunet-publish-29357 DEBUG Reservation complete (12)! Jul 06 16:52:20-079159 util-scheduler-29357 DEBUG Adding task 0x6183b0 Jul 06 16:52:20-079197 util-mst-29357 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:52:20-079237 util-scheduler-29357 DEBUG destroying task 0x6185f0 Jul 06 16:52:20-079290 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-079332 util-scheduler-29357 DEBUG Running task 0x618580 Jul 06 16:52:20-079371 util-client-29357 DEBUG message of type 168 trying to send with socket 0x618208 (MQ: 0x617848 Jul 06 16:52:20-079421 util-client-29357 DEBUG sending message of type 168 successful Jul 06 16:52:20-079460 util-scheduler-29357 DEBUG Adding task 0x6185f0 Jul 06 16:52:20-079499 util-scheduler-29357 DEBUG destroying task 0x618580 Jul 06 16:52:20-079536 util-scheduler-29357 DEBUG scheduler has more tasks ready! Jul 06 16:52:20-079587 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-079627 util-scheduler-29357 DEBUG Running task 0x6185f0 Jul 06 16:52:20-079665 util-scheduler-29357 DEBUG destroying task 0x6185f0 Jul 06 16:52:20-079702 util-scheduler-29357 DEBUG scheduler has more tasks ready! Jul 06 16:52:20-079783 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-079825 util-scheduler-29357 DEBUG Running task 0x6183b0 Jul 06 16:52:20-080030 util-scheduler-29357 DEBUG Adding task 0x617ed8 Jul 06 16:52:20-080071 util-scheduler-29357 DEBUG destroying task 0x6183b0 Jul 06 16:52:20-080124 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-080165 util-scheduler-29357 DEBUG Running task 0x617ed8 Jul 06 16:52:20-080246 gnunet-publish-29357 DEBUG Hash of indexed file `/home/xrs/text.txt' is `SY1Y2DBY' Jul 06 16:52:20-080298 util-29357 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-fs.sock Jul 06 16:52:20-080337 util-29357 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-fs.sock' with default (null) Jul 06 16:52:20-080379 util-29357 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:52:20-080421 util-29357 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:52:20-080461 util-29357 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:52:20-080499 util-29357 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:52:20-080538 util-29357 DEBUG Asked to $-expand /tmp Jul 06 16:52:20-080575 util-29357 DEBUG Doesn't start with $ - not expanding Jul 06 16:52:20-080629 util-scheduler-29357 DEBUG Adding task 0x618b10 Jul 06 16:52:20-080709 util-mq-29357 DEBUG sending message of type 128, queue empty (MQ: 0x618b80) Jul 06 16:52:20-080748 util-client-29357 DEBUG message of type 128 waiting for socket Jul 06 16:52:20-081072 util-scheduler-29357 DEBUG destroying task 0x617ed8 Jul 06 16:52:20-081135 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-081180 util-scheduler-29357 DEBUG Running task 0x618b10 Jul 06 16:52:20-081222 util-29357 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-fs.sock Jul 06 16:52:20-081261 util-29357 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-fs.sock' with default (null) Jul 06 16:52:20-081305 util-29357 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:52:20-081344 util-29357 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:52:20-081387 util-29357 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:52:20-081426 util-29357 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:52:20-081466 util-29357 DEBUG Asked to $-expand /tmp Jul 06 16:52:20-081502 util-29357 DEBUG Doesn't start with $ - not expanding Jul 06 16:52:20-081849 util-client-29357 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-fs.sock'! Jul 06 16:52:20-081927 util-scheduler-29357 DEBUG destroying task 0x618b10 Jul 06 16:52:20-081972 util-scheduler-29357 DEBUG select timeout = end of time Jul 06 16:52:20-082021 util-scheduler-29357 DEBUG Running task 0x618758 Jul 06 16:52:20-082061 util-client-29357 DEBUG message of type 128 trying to send with socket 0x618198 (MQ: 0x618b80 Jul 06 16:52:20-082118 util-client-29357 DEBUG sending message of type 128 successful Jul 06 16:52:20-082159 util-scheduler-29357 DEBUG Adding task 0x6187c8 Jul 06 16:52:20-082200 util-scheduler-29357 DEBUG destroying task 0x618758 Jul 06 16:52:20-082254 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-082297 util-scheduler-29357 DEBUG Running task 0x6187c8 Jul 06 16:52:20-082336 util-scheduler-29357 DEBUG destroying task 0x6187c8 Jul 06 16:52:20-082376 util-scheduler-29357 DEBUG select timeout = end of time Jul 06 16:52:20-082680 util-scheduler-29357 DEBUG Running task 0x6186e8 Jul 06 16:52:20-082777 util-mst-29357 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Jul 06 16:52:20-082822 util-client-29357 DEBUG Received message of type 130 and size 4 from fs Jul 06 16:52:20-082862 util-mq-29357 DEBUG Received message of type 130 and size 4 Jul 06 16:52:20-082979 util-scheduler-29357 DEBUG GNUNET_SCHEDULER_shutdown Jul 06 16:52:20-083019 util-scheduler-29357 DEBUG canceling task 0x617178 Jul 06 16:52:20-083118 util-scheduler-29357 DEBUG destroying task 0x617178 Jul 06 16:52:20-083165 util-client-29357 DEBUG destroying socket: 0x618198 Jul 06 16:52:20-083242 util-scheduler-29357 DEBUG destroying task 0x6186e8 Jul 06 16:52:20-083283 util-scheduler-29357 DEBUG scheduler has more tasks ready! Jul 06 16:52:20-083339 util-scheduler-29357 DEBUG select timeout = Sat Jul 06 16:52:20 2019 Jul 06 16:52:20-083383 util-scheduler-29357 DEBUG Running task 0x617478 Jul 06 16:52:20-083425 util-scheduler-29357 DEBUG destroying task 0x617478 Jul 06 16:52:20-083463 util-scheduler-29357 DEBUG Running task 0x617560 Jul 06 16:52:20-083505 gnunet-publish-29357 DEBUG Publish stop called Jul 06 16:52:20-083550 gnunet-publish-29357 DEBUG Cleaning up publish context (done!) Jul 06 16:52:20-083724 datastore-api-29357 DEBUG Datastore disconnect Jul 06 16:52:20-083769 util-scheduler-29357 DEBUG canceling task 0x618678 Jul 06 16:52:20-083808 util-scheduler-29357 DEBUG destroying task 0x618678 Jul 06 16:52:20-083846 util-client-29357 DEBUG destroying socket: 0x618440 Jul 06 16:52:20-083923 gnunet-publish-29357 DEBUG Cleaning all up Jul 06 16:52:20-083964 util-scheduler-29357 DEBUG canceling task 0x618468 Jul 06 16:52:20-084002 util-scheduler-29357 DEBUG destroying task 0x618468 Jul 06 16:52:20-084041 util-client-29357 DEBUG destroying socket: 0x618208 Jul 06 16:52:20-084103 util-scheduler-29357 DEBUG destroying task 0x617560 Jul 06 16:52:20-084145 util-scheduler-29357 DEBUG GNUNET_SCHEDULER_shutdown gnunet-2019-07-06.log (95,579 bytes)
Jul 06 16:55:03-379678 util-30573 ERROR Have neither PORT nor UNIXPATH for service `exit', but one is required Jul 06 16:55:03-514800 util-30582 DEBUG Asked to $-expand $GNUNET_DATA_HOME/private_key.ecc Jul 06 16:55:03-515053 util-30582 DEBUG Split into `GNUNET_DATA_HOME' and `private_key.ecc' with default (null) Jul 06 16:55:03-515112 util-30582 DEBUG Asked to $-expand ${XDG_DATA_HOME:-$GNUNET_HOME/.local/share}/gnunet/ Jul 06 16:55:03-515154 util-30582 DEBUG Split into `XDG_DATA_HOME' and `/gnunet/' with default $GNUNET_HOME/.local/share Jul 06 16:55:03-515195 util-30582 DEBUG Asked to $-expand $GNUNET_HOME/.local/share Jul 06 16:55:03-515232 util-30582 DEBUG Split into `GNUNET_HOME' and `.local/share' with default (null) Jul 06 16:55:03-515272 util-30582 DEBUG Asked to $-expand ${GNUNET_TEST_HOME:-${HOME:-${USERPROFILE}}} Jul 06 16:55:03-515311 util-30582 DEBUG Split into `GNUNET_TEST_HOME' and `' with default ${HOME:-${USERPROFILE}} Jul 06 16:55:03-515350 util-30582 DEBUG Asked to $-expand ${HOME:-${USERPROFILE}} Jul 06 16:55:03-515388 util-30582 DEBUG Split into `HOME' and `' with default ${USERPROFILE} Jul 06 16:55:03-606229 rps-30582 INFO STARTING SERVICE (rps) for peer [QYYZ] Jul 06 16:55:03-606456 cadet-api-30582 DEBUG GNUNET_CADET_connect() Jul 06 16:55:03-606532 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-cadet.sock Jul 06 16:55:03-606575 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-cadet.sock' with default (null) Jul 06 16:55:03-606618 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-606658 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-606698 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-606735 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-606774 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-606810 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-606905 core-api-30582 DEBUG Connecting to CORE service Jul 06 16:55:03-606952 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-core.sock Jul 06 16:55:03-606991 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-core.sock' with default (null) Jul 06 16:55:03-607032 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-607070 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-607108 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-607145 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-607183 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-607218 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-607278 core-api-30582 INFO (Re)connecting to CORE service Jul 06 16:55:03-607320 util-mq-30582 DEBUG sending message of type 64, queue empty (MQ: 0x17ce6a0) Jul 06 16:55:03-607359 util-client-30582 DEBUG message of type 64 waiting for socket Jul 06 16:55:03-607459 rps-30582 DEBUG Listening to CADET port RNN0WW1R Jul 06 16:55:03-607513 util-mq-30582 DEBUG sending message of type 1022, queue empty (MQ: 0x17cf158) Jul 06 16:55:03-607551 util-client-30582 DEBUG message of type 1022 waiting for socket Jul 06 16:55:03-607600 util-30582 DEBUG Asked to $-expand $GNUNET_DATA_HOME/rps/valid_peers.txt Jul 06 16:55:03-607637 util-30582 DEBUG Split into `GNUNET_DATA_HOME' and `rps/valid_peers.txt' with default (null) Jul 06 16:55:03-607678 util-30582 DEBUG Asked to $-expand ${XDG_DATA_HOME:-$GNUNET_HOME/.local/share}/gnunet/ Jul 06 16:55:03-607716 util-30582 DEBUG Split into `XDG_DATA_HOME' and `/gnunet/' with default $GNUNET_HOME/.local/share Jul 06 16:55:03-607755 util-30582 DEBUG Asked to $-expand $GNUNET_HOME/.local/share Jul 06 16:55:03-607791 util-30582 DEBUG Split into `GNUNET_HOME' and `.local/share' with default (null) Jul 06 16:55:03-607831 util-30582 DEBUG Asked to $-expand ${GNUNET_TEST_HOME:-${HOME:-${USERPROFILE}}} Jul 06 16:55:03-607869 util-30582 DEBUG Split into `GNUNET_TEST_HOME' and `' with default ${HOME:-${USERPROFILE}} Jul 06 16:55:03-607971 util-30582 DEBUG Asked to $-expand ${HOME:-${USERPROFILE}} Jul 06 16:55:03-608011 util-30582 DEBUG Split into `HOME' and `' with default ${USERPROFILE} Jul 06 16:55:03-608098 rps-30582 DEBUG MINSIZE is 10 Jul 06 16:55:03-608143 rps-sampler_common-30582 DEBUG Growing sampler 0 -> 10 Jul 06 16:55:03-609148 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-peerinfo.sock Jul 06 16:55:03-609194 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-peerinfo.sock' with default (null) Jul 06 16:55:03-609236 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-609274 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-609313 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-609350 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-609388 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-609423 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-609488 nse-api-30582 DEBUG Connecting to network size estimation service. Jul 06 16:55:03-609530 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-nse.sock Jul 06 16:55:03-609568 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-nse.sock' with default (null) Jul 06 16:55:03-609607 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-609645 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-609684 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-609720 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-609757 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-609792 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-609849 util-mq-30582 DEBUG sending message of type 321, queue empty (MQ: 0x17d0ae8) Jul 06 16:55:03-609887 util-client-30582 DEBUG message of type 321 waiting for socket Jul 06 16:55:03-609921 rps-30582 DEBUG Requesting stored valid peers Jul 06 16:55:03-610058 rps-30582 DEBUG Restoring 2 peers from file `/home/gnunet/.local/share/gnunet//rps/valid_peers.txtRNN0WW1RJNTMAX2GFZMF6EGYYXQWX5P970ECBH25DY5JJRHQE284BVQ5XHZTTWBQCJ31P7CDXXDTDWZXWYPGWV101SXNYX3MEW7GPCR' Jul 06 16:55:03-610121 rps-30582 DEBUG Restored valid peer 9670C26Y24RWY86PDRPPNCYVTC3ER0T6AQ9VT97S4HYQ4ZJZXYNG from disk Jul 06 16:55:03-610164 rps-30582 DEBUG Restored valid peer QYYZ9S0GMRS5GJGA415YEFB29RM1E4NJ4NX8DG0T8GYFDJVYHNJ0 from disk Jul 06 16:55:03-610200 rps-30582 DEBUG num_peers: 2, _size (sub->valid_peers): 2 Jul 06 16:55:03-610242 rps-30582 DEBUG Restored 2 valid peers from disk Jul 06 16:55:03-610283 rps-30582 DEBUG Got stored, valid peer 9670 Jul 06 16:55:03-610334 rps-30582 DEBUG Get informed about peer 9670 getting online Jul 06 16:55:03-610374 rps-30582 DEBUG Trying to establish channel to peer 9670 Jul 06 16:55:03-610420 rps-30582 DEBUG Creating channel to peer 9670 at port RNN0WW1R Jul 06 16:55:03-610498 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d0f20) Jul 06 16:55:03-610550 rps-30582 DEBUG Got stored, valid peer QYYZ Jul 06 16:55:03-610589 rps-30582 DEBUG Get informed about peer QYYZ getting online Jul 06 16:55:03-610626 rps-30582 DEBUG Trying to establish channel to peer QYYZ Jul 06 16:55:03-610664 rps-30582 DEBUG Creating channel to peer QYYZ at port RNN0WW1R Jul 06 16:55:03-610704 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d1188) Jul 06 16:55:03-610751 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-peerinfo.sock Jul 06 16:55:03-610789 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-peerinfo.sock' with default (null) Jul 06 16:55:03-610830 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-610867 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-610941 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-610978 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-611016 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-611051 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-611107 util-mq-30582 DEBUG sending message of type 334, queue empty (MQ: 0x17d14f0) Jul 06 16:55:03-611145 util-client-30582 DEBUG message of type 334 waiting for socket Jul 06 16:55:03-611179 rps-30582 INFO Ready to receive requests from clients Jul 06 16:55:03-611252 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-peerinfo.sock Jul 06 16:55:03-611290 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-peerinfo.sock' with default (null) Jul 06 16:55:03-611330 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-611368 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-611406 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-611443 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-611480 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-611515 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-611636 util-client-30582 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-peerinfo.sock'! Jul 06 16:55:03-611687 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-nse.sock Jul 06 16:55:03-611726 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-nse.sock' with default (null) Jul 06 16:55:03-611766 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-611803 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-611841 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-611877 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-611914 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-611948 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-612026 util-client-30582 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-nse.sock'! Jul 06 16:55:03-612071 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-peerinfo.sock Jul 06 16:55:03-612108 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-peerinfo.sock' with default (null) Jul 06 16:55:03-612149 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-612186 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-612224 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-612261 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-612298 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-612333 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-612408 util-client-30582 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-peerinfo.sock'! Jul 06 16:55:03-612451 rps-30582 DEBUG Going to execute next round. Jul 06 16:55:03-612511 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-statistics.sock Jul 06 16:55:03-612550 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-statistics.sock' with default (null) Jul 06 16:55:03-612593 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-612631 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-612670 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-612707 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-612746 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-612781 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-612868 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:03-612951 util-client-30582 DEBUG message of type 168 waiting for socket Jul 06 16:55:03-612993 rps-30582 DEBUG No update of the view. Jul 06 16:55:03-613079 rps-30582 DEBUG Received 0 pushes and 0 pulls last round (alpha (0.45) * view_size (sub->view0) = 0.00) Jul 06 16:55:03-613170 rps-30582 DEBUG Finished round Jul 06 16:55:03-613218 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-core.sock Jul 06 16:55:03-613259 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-core.sock' with default (null) Jul 06 16:55:03-613301 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-613340 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-613379 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-613416 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-613455 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-613491 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-614640 util-client-30582 DEBUG Failed to establish connection to `core', no further addresses to try, will try again in 2 ms. Jul 06 16:55:03-614774 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-cadet.sock Jul 06 16:55:03-614819 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-cadet.sock' with default (null) Jul 06 16:55:03-614862 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-614920 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-614961 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-615014 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-615055 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-615091 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-615552 util-client-30582 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-cadet.sock'! Jul 06 16:55:03-615685 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-statistics.sock Jul 06 16:55:03-615730 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-statistics.sock' with default (null) Jul 06 16:55:03-615794 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-615835 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-615891 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-615932 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-615970 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-616026 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-616299 util-client-30582 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-statistics.sock'! Jul 06 16:55:03-616358 util-client-30582 DEBUG message of type 334 trying to send with socket 0x17d1658 (MQ: 0x17d14f0 Jul 06 16:55:03-616462 util-client-30582 DEBUG sending message of type 334 successful Jul 06 16:55:03-616531 util-client-30582 DEBUG message of type 321 trying to send with socket 0x17d1340 (MQ: 0x17d0ae8 Jul 06 16:55:03-616580 util-client-30582 DEBUG sending message of type 321 successful Jul 06 16:55:03-616642 util-client-30582 DEBUG message of type 1022 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-617009 util-client-30582 DEBUG sending message of type 1022 successful Jul 06 16:55:03-617092 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-617166 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-core.sock Jul 06 16:55:03-617207 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-core.sock' with default (null) Jul 06 16:55:03-617268 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-617333 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-617397 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-617439 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-617478 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-617533 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-617696 util-client-30582 DEBUG Failed to establish connection to `core', no further addresses to try, will try again in 4 ms. Jul 06 16:55:03-617762 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-618019 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-618109 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-618176 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-618980 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-619134 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-619189 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-619383 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-619443 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-619486 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-619532 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-619583 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-619714 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-619766 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-619824 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-619929 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-619982 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-620038 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-622807 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-622945 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-623003 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-core.sock Jul 06 16:55:03-623044 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-core.sock' with default (null) Jul 06 16:55:03-623088 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-623127 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-623166 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-623204 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-623242 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-623277 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-623413 util-client-30582 DEBUG Failed to establish connection to `core', no further addresses to try, will try again in 8 ms. Jul 06 16:55:03-623475 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-623762 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-623869 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-623950 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-624108 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-624181 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-624255 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-624406 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-624504 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-624562 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-624675 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-631602 util-mst-30582 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Jul 06 16:55:03-633061 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-core.sock Jul 06 16:55:03-633156 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-core.sock' with default (null) Jul 06 16:55:03-633203 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-633242 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-633282 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-633319 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-633358 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-633394 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-633662 util-client-30582 DEBUG Failed to establish connection to `core', no further addresses to try, will try again in 16 ms. Jul 06 16:55:03-633776 util-mst-30582 DEBUG MST receives 0 bytes with 116 bytes already in private buffer Jul 06 16:55:03-633820 util-client-30582 DEBUG Received message of type 332 and size 116 from peerinfo Jul 06 16:55:03-633881 util-mq-30582 DEBUG Received message of type 332 and size 116 Jul 06 16:55:03-633945 peerinfo-api-30582 DEBUG Received information about peer `11YB' from peerinfo database Jul 06 16:55:03-633985 rps-30582 DEBUG Got peer_id 11YB from peerinfo Jul 06 16:55:03-634045 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:03-634098 rps-30582 DEBUG Get informed about peer 11YB getting online Jul 06 16:55:03-634138 rps-30582 DEBUG Trying to establish channel to peer 11YB Jul 06 16:55:03-634181 rps-30582 DEBUG Creating channel to peer 11YB at port RNN0WW1R Jul 06 16:55:03-634229 util-mq-30582 DEBUG sending message of type 1024, queue empty (MQ: 0x17cf158) Jul 06 16:55:03-634271 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d1b40) Jul 06 16:55:03-634325 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-634419 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-643945 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-644121 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-644190 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-644259 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-644314 util-mst-30582 DEBUG MST receives 0 bytes with 116 bytes already in private buffer Jul 06 16:55:03-644378 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-644445 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-644499 util-mst-30582 DEBUG MST receives 0 bytes with 128 bytes already in private buffer Jul 06 16:55:03-644543 util-client-30582 DEBUG Received message of type 332 and size 128 from peerinfo Jul 06 16:55:03-644582 util-mq-30582 DEBUG Received message of type 332 and size 128 Jul 06 16:55:03-644625 peerinfo-api-30582 DEBUG Received information about peer `3969' from peerinfo database Jul 06 16:55:03-644666 rps-30582 DEBUG Got peer_id 3969 from peerinfo Jul 06 16:55:03-644716 rps-30582 DEBUG Get informed about peer 3969 getting online Jul 06 16:55:03-644756 rps-30582 DEBUG Trying to establish channel to peer 3969 Jul 06 16:55:03-644803 rps-30582 DEBUG Creating channel to peer 3969 at port RNN0WW1R Jul 06 16:55:03-644852 util-mq-30582 DEBUG sending message of type 1024, queue empty (MQ: 0x17cf158) Jul 06 16:55:03-644897 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d2510) Jul 06 16:55:03-645009 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-645075 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-645121 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-645170 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-645221 util-mst-30582 DEBUG MST receives 0 bytes with 128 bytes already in private buffer Jul 06 16:55:03-645261 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-645302 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-645344 peerinfo-api-30582 DEBUG Received information about peer `4W6C' from peerinfo database Jul 06 16:55:03-645382 rps-30582 DEBUG Got peer_id 4W6C from peerinfo Jul 06 16:55:03-645434 rps-30582 DEBUG Get informed about peer 4W6C getting online Jul 06 16:55:03-645474 rps-30582 DEBUG Trying to establish channel to peer 4W6C Jul 06 16:55:03-645515 rps-30582 DEBUG Creating channel to peer 4W6C at port RNN0WW1R Jul 06 16:55:03-645564 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d2778) Jul 06 16:55:03-645668 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-645715 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-645772 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-645836 util-mst-30582 DEBUG MST receives 0 bytes with 344 bytes already in private buffer Jul 06 16:55:03-645877 util-client-30582 DEBUG Received message of type 332 and size 344 from peerinfo Jul 06 16:55:03-645920 util-mq-30582 DEBUG Received message of type 332 and size 344 Jul 06 16:55:03-645963 peerinfo-api-30582 DEBUG Received information about peer `Y924' from peerinfo database Jul 06 16:55:03-646000 rps-30582 DEBUG Got peer_id Y924 from peerinfo Jul 06 16:55:03-646051 rps-30582 DEBUG Get informed about peer Y924 getting online Jul 06 16:55:03-646091 rps-30582 DEBUG Trying to establish channel to peer Y924 Jul 06 16:55:03-646132 rps-30582 DEBUG Creating channel to peer Y924 at port RNN0WW1R Jul 06 16:55:03-646206 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d2b20) Jul 06 16:55:03-646262 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-646340 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-646385 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-646435 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-646493 util-mst-30582 DEBUG MST receives 0 bytes with 344 bytes already in private buffer Jul 06 16:55:03-646533 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-646573 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-646613 peerinfo-api-30582 DEBUG Received information about peer `0MJS' from peerinfo database Jul 06 16:55:03-646652 rps-30582 DEBUG Got peer_id 0MJS from peerinfo Jul 06 16:55:03-646701 rps-30582 DEBUG Get informed about peer 0MJS getting online Jul 06 16:55:03-646742 rps-30582 DEBUG Trying to establish channel to peer 0MJS Jul 06 16:55:03-646789 rps-30582 DEBUG Creating channel to peer 0MJS at port RNN0WW1R Jul 06 16:55:03-646839 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d2e10) Jul 06 16:55:03-646889 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-646930 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-646970 peerinfo-api-30582 DEBUG Received information about peer `DFAN' from peerinfo database Jul 06 16:55:03-647007 rps-30582 DEBUG Got peer_id DFAN from peerinfo Jul 06 16:55:03-647069 rps-30582 DEBUG Get informed about peer DFAN getting online Jul 06 16:55:03-647111 rps-30582 DEBUG Trying to establish channel to peer DFAN Jul 06 16:55:03-647024 transport-30596 ERROR Assertion failed at gnunet-service-transport_validation.c:898. Jul 06 16:55:03-647203 rps-30582 DEBUG Creating channel to peer DFAN at port RNN0WW1R Jul 06 16:55:03-647246 transport-30596 ERROR Address with 24 bytes for plugin tcp and peer DSTJ is malformed Jul 06 16:55:03-647250 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d30b8) Jul 06 16:55:03-647294 transport-30596 ERROR Assertion failed at gnunet-service-transport_validation.c:898. Jul 06 16:55:03-647334 transport-30596 ERROR Address with 12 bytes for plugin tcp and peer DSTJ is malformed Jul 06 16:55:03-647350 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-647396 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-647484 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-647545 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-647586 util-client-30582 DEBUG Received message of type 332 and size 588 from peerinfo Jul 06 16:55:03-647624 util-mq-30582 DEBUG Received message of type 332 and size 588 Jul 06 16:55:03-647668 peerinfo-api-30582 DEBUG Received information about peer `DSTJ' from peerinfo database Jul 06 16:55:03-647706 rps-30582 DEBUG Got peer_id DSTJ from peerinfo Jul 06 16:55:03-647752 rps-30582 DEBUG Get informed about peer DSTJ getting online Jul 06 16:55:03-647795 rps-30582 DEBUG Trying to establish channel to peer DSTJ Jul 06 16:55:03-647836 rps-30582 DEBUG Creating channel to peer DSTJ at port RNN0WW1R Jul 06 16:55:03-647881 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d3588) Jul 06 16:55:03-647931 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-647988 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-648032 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-648080 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-648136 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-648176 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-648213 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-648252 peerinfo-api-30582 DEBUG Received information about peer `P54S' from peerinfo database Jul 06 16:55:03-648290 rps-30582 DEBUG Got peer_id P54S from peerinfo Jul 06 16:55:03-648332 rps-30582 DEBUG Get informed about peer P54S getting online Jul 06 16:55:03-648369 rps-30582 DEBUG Trying to establish channel to peer P54S Jul 06 16:55:03-648408 rps-30582 DEBUG Creating channel to peer P54S at port RNN0WW1R Jul 06 16:55:03-648451 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d3810) Jul 06 16:55:03-648497 util-client-30582 DEBUG Received message of type 332 and size 296 from peerinfo Jul 06 16:55:03-648536 util-mq-30582 DEBUG Received message of type 332 and size 296 Jul 06 16:55:03-648575 peerinfo-api-30582 DEBUG Received information about peer `QYYZ' from peerinfo database Jul 06 16:55:03-648610 rps-30582 DEBUG Got peer_id QYYZ from peerinfo Jul 06 16:55:03-648651 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-648689 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-648728 peerinfo-api-30582 DEBUG Received information about peer `ZVMT' from peerinfo database Jul 06 16:55:03-648764 rps-30582 DEBUG Got peer_id ZVMT from peerinfo Jul 06 16:55:03-648807 rps-30582 DEBUG Get informed about peer ZVMT getting online Jul 06 16:55:03-648844 rps-30582 DEBUG Trying to establish channel to peer ZVMT Jul 06 16:55:03-648882 rps-30582 DEBUG Creating channel to peer ZVMT at port RNN0WW1R Jul 06 16:55:03-648925 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d3ae0) Jul 06 16:55:03-648987 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-649081 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-649198 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-649265 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-649307 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-649345 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-649385 peerinfo-api-30582 DEBUG Received information about peer `FD3C' from peerinfo database Jul 06 16:55:03-649424 rps-30582 DEBUG Got peer_id FD3C from peerinfo Jul 06 16:55:03-649467 rps-30582 DEBUG Get informed about peer FD3C getting online Jul 06 16:55:03-649506 rps-30582 DEBUG Trying to establish channel to peer FD3C Jul 06 16:55:03-649547 rps-30582 DEBUG Creating channel to peer FD3C at port RNN0WW1R Jul 06 16:55:03-649590 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d3d88) Jul 06 16:55:03-649636 util-client-30582 DEBUG Received message of type 332 and size 116 from peerinfo Jul 06 16:55:03-649675 util-mq-30582 DEBUG Received message of type 332 and size 116 Jul 06 16:55:03-649714 peerinfo-api-30582 DEBUG Received information about peer `FX9A' from peerinfo database Jul 06 16:55:03-649750 rps-30582 DEBUG Got peer_id FX9A from peerinfo Jul 06 16:55:03-649812 rps-30582 DEBUG Get informed about peer FX9A getting online Jul 06 16:55:03-649850 rps-30582 DEBUG Trying to establish channel to peer FX9A Jul 06 16:55:03-649889 rps-30582 DEBUG Creating channel to peer FX9A at port RNN0WW1R Jul 06 16:55:03-649935 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d4110) Jul 06 16:55:03-649980 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-650018 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-650058 peerinfo-api-30582 DEBUG Received information about peer `TQ9D' from peerinfo database Jul 06 16:55:03-650094 rps-30582 DEBUG Got peer_id TQ9D from peerinfo Jul 06 16:55:03-650135 rps-30582 DEBUG Get informed about peer TQ9D getting online Jul 06 16:55:03-650173 rps-30582 DEBUG Trying to establish channel to peer TQ9D Jul 06 16:55:03-650212 rps-30582 DEBUG Creating channel to peer TQ9D at port RNN0WW1R Jul 06 16:55:03-650252 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d43d0) Jul 06 16:55:03-650299 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-650337 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-650375 peerinfo-api-30582 DEBUG Received information about peer `XJHB' from peerinfo database Jul 06 16:55:03-650414 rps-30582 DEBUG Got peer_id XJHB from peerinfo Jul 06 16:55:03-650455 rps-30582 DEBUG Get informed about peer XJHB getting online Jul 06 16:55:03-650531 rps-30582 DEBUG Trying to establish channel to peer XJHB Jul 06 16:55:03-650572 rps-30582 DEBUG Creating channel to peer XJHB at port RNN0WW1R Jul 06 16:55:03-650613 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d46a0) Jul 06 16:55:03-650661 util-client-30582 DEBUG Received message of type 332 and size 128 from peerinfo Jul 06 16:55:03-650699 util-mq-30582 DEBUG Received message of type 332 and size 128 Jul 06 16:55:03-650738 peerinfo-api-30582 DEBUG Received information about peer `0Y5X' from peerinfo database Jul 06 16:55:03-650882 rps-30582 DEBUG Got peer_id 0Y5X from peerinfo Jul 06 16:55:03-650928 rps-30582 DEBUG Get informed about peer 0Y5X getting online Jul 06 16:55:03-650966 rps-30582 DEBUG Trying to establish channel to peer 0Y5X Jul 06 16:55:03-651005 rps-30582 DEBUG Creating channel to peer 0Y5X at port RNN0WW1R Jul 06 16:55:03-651050 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d4970) Jul 06 16:55:03-651128 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-core.sock Jul 06 16:55:03-651170 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-core.sock' with default (null) Jul 06 16:55:03-651261 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-651302 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-651342 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-651380 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-651420 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-651456 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-651623 util-client-30582 DEBUG Failed to establish connection to `core', no further addresses to try, will try again in 32 ms. Jul 06 16:55:03-651671 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-651714 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-651760 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-651822 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-651861 util-client-30582 DEBUG Received message of type 332 and size 164 from peerinfo Jul 06 16:55:03-651899 util-mq-30582 DEBUG Received message of type 332 and size 164 Jul 06 16:55:03-651940 peerinfo-api-30582 DEBUG Received information about peer `5WBG' from peerinfo database Jul 06 16:55:03-651978 rps-30582 DEBUG Got peer_id 5WBG from peerinfo Jul 06 16:55:03-652021 rps-30582 DEBUG Get informed about peer 5WBG getting online Jul 06 16:55:03-652061 rps-30582 DEBUG Trying to establish channel to peer 5WBG Jul 06 16:55:03-652100 rps-30582 DEBUG Creating channel to peer 5WBG at port RNN0WW1R Jul 06 16:55:03-652142 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d4d30) Jul 06 16:55:03-652189 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-652227 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-652265 peerinfo-api-30582 DEBUG Received information about peer `N97R' from peerinfo database Jul 06 16:55:03-652303 rps-30582 DEBUG Got peer_id N97R from peerinfo Jul 06 16:55:03-652342 rps-30582 DEBUG Get informed about peer N97R getting online Jul 06 16:55:03-652380 rps-30582 DEBUG Trying to establish channel to peer N97R Jul 06 16:55:03-652419 rps-30582 DEBUG Creating channel to peer N97R at port RNN0WW1R Jul 06 16:55:03-652459 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d4fa0) Jul 06 16:55:03-652504 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-652543 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-652582 peerinfo-api-30582 DEBUG Received information about peer `QWNV' from peerinfo database Jul 06 16:55:03-652618 rps-30582 DEBUG Got peer_id QWNV from peerinfo Jul 06 16:55:03-652658 rps-30582 DEBUG Get informed about peer QWNV getting online Jul 06 16:55:03-652698 rps-30582 DEBUG Trying to establish channel to peer QWNV Jul 06 16:55:03-652736 rps-30582 DEBUG Creating channel to peer QWNV at port RNN0WW1R Jul 06 16:55:03-652776 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d5238) Jul 06 16:55:03-652840 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-652884 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-652943 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-653004 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-653045 util-client-30582 DEBUG Received message of type 332 and size 248 from peerinfo Jul 06 16:55:03-653083 util-mq-30582 DEBUG Received message of type 332 and size 248 Jul 06 16:55:03-653122 peerinfo-api-30582 DEBUG Received information about peer `V93S' from peerinfo database Jul 06 16:55:03-653158 rps-30582 DEBUG Got peer_id V93S from peerinfo Jul 06 16:55:03-653204 rps-30582 DEBUG Get informed about peer V93S getting online Jul 06 16:55:03-653242 rps-30582 DEBUG Trying to establish channel to peer V93S Jul 06 16:55:03-653323 rps-30582 DEBUG Creating channel to peer V93S at port RNN0WW1R Jul 06 16:55:03-653368 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d5508) Jul 06 16:55:03-653436 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-653526 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-655723 transport-30596 ERROR Assertion failed at gnunet-service-transport_validation.c:898. Jul 06 16:55:03-670570 transport-30596 ERROR Address with 24 bytes for plugin tcp and peer V8XX is malformed Jul 06 16:55:03-670669 transport-30596 ERROR Assertion failed at gnunet-service-transport_validation.c:898. Jul 06 16:55:03-670710 transport-30596 ERROR Address with 12 bytes for plugin tcp and peer V8XX is malformed Jul 06 16:55:03-676326 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-676492 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-676539 util-client-30582 DEBUG Received message of type 332 and size 422 from peerinfo Jul 06 16:55:03-676579 util-mq-30582 DEBUG Received message of type 332 and size 422 Jul 06 16:55:03-676622 peerinfo-api-30582 DEBUG Received information about peer `V8XX' from peerinfo database Jul 06 16:55:03-676665 rps-30582 DEBUG Got peer_id V8XX from peerinfo Jul 06 16:55:03-676717 rps-30582 DEBUG Get informed about peer V8XX getting online Jul 06 16:55:03-676757 rps-30582 DEBUG Trying to establish channel to peer V8XX Jul 06 16:55:03-676813 rps-30582 DEBUG Creating channel to peer V8XX at port RNN0WW1R Jul 06 16:55:03-676872 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d5800) Jul 06 16:55:03-676931 util-client-30582 DEBUG Received message of type 332 and size 116 from peerinfo Jul 06 16:55:03-676970 util-mq-30582 DEBUG Received message of type 332 and size 116 Jul 06 16:55:03-677010 peerinfo-api-30582 DEBUG Received information about peer `VF3X' from peerinfo database Jul 06 16:55:03-677050 rps-30582 DEBUG Got peer_id VF3X from peerinfo Jul 06 16:55:03-677098 rps-30582 DEBUG Get informed about peer VF3X getting online Jul 06 16:55:03-677138 rps-30582 DEBUG Trying to establish channel to peer VF3X Jul 06 16:55:03-677186 rps-30582 DEBUG Creating channel to peer VF3X at port RNN0WW1R Jul 06 16:55:03-677245 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17d5aa8) Jul 06 16:55:03-677331 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-677390 util-mst-30582 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Jul 06 16:55:03-677443 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-677493 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-677558 util-mst-30582 DEBUG MST receives 0 bytes with 472 bytes already in private buffer Jul 06 16:55:03-677597 util-client-30582 DEBUG Received message of type 332 and size 116 from peerinfo Jul 06 16:55:03-677634 util-mq-30582 DEBUG Received message of type 332 and size 116 Jul 06 16:55:03-677677 peerinfo-api-30582 DEBUG Received information about peer `W77X' from peerinfo database Jul 06 16:55:03-677715 rps-30582 DEBUG Got peer_id W77X from peerinfo Jul 06 16:55:03-677763 rps-30582 DEBUG Get informed about peer W77X getting online Jul 06 16:55:03-677803 rps-30582 DEBUG Trying to establish channel to peer W77X Jul 06 16:55:03-677846 rps-30582 DEBUG Creating channel to peer W77X at port RNN0WW1R Jul 06 16:55:03-677899 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17e1848) Jul 06 16:55:03-677963 util-client-30582 DEBUG Received message of type 332 and size 116 from peerinfo Jul 06 16:55:03-678026 util-mq-30582 DEBUG Received message of type 332 and size 116 Jul 06 16:55:03-678089 peerinfo-api-30582 DEBUG Received information about peer `Y33M' from peerinfo database Jul 06 16:55:03-678139 rps-30582 DEBUG Got peer_id Y33M from peerinfo Jul 06 16:55:03-678235 rps-30582 DEBUG Get informed about peer Y33M getting online Jul 06 16:55:03-678278 rps-30582 DEBUG Trying to establish channel to peer Y33M Jul 06 16:55:03-678325 rps-30582 DEBUG Creating channel to peer Y33M at port RNN0WW1R Jul 06 16:55:03-678377 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17e1ac8) Jul 06 16:55:03-678437 util-client-30582 DEBUG Received message of type 333 and size 4 from peerinfo Jul 06 16:55:03-678476 util-mq-30582 DEBUG Received message of type 333 and size 4 Jul 06 16:55:03-678544 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-678591 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-678649 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-678728 util-mst-30582 DEBUG MST receives 0 bytes with 32 bytes already in private buffer Jul 06 16:55:03-678768 util-client-30582 DEBUG Received message of type 323 and size 32 from nse Jul 06 16:55:03-678807 util-mq-30582 DEBUG Received message of type 323 and size 32 Jul 06 16:55:03-678876 rps-30582 DEBUG Received a ns estimate - logest: 0.000000, std_dev: 0.000000 (old_size: 10) Jul 06 16:55:03-679018 rps-30582 DEBUG Not using estimate 1.000000 Jul 06 16:55:03-679072 rps-30582 DEBUG sampler_size is now 10 Jul 06 16:55:03-679117 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-679175 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-679215 util-client-30582 DEBUG Received message of type 332 and size 296 from peerinfo Jul 06 16:55:03-679253 util-mq-30582 DEBUG Received message of type 332 and size 296 Jul 06 16:55:03-679299 peerinfo-api-30582 DEBUG Received information about peer `QYYZ' from peerinfo database Jul 06 16:55:03-679338 rps-30582 DEBUG Got peer_id QYYZ from peerinfo Jul 06 16:55:03-679405 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-679454 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-679502 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-679556 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-679595 util-client-30582 DEBUG Received message of type 332 and size 296 from peerinfo Jul 06 16:55:03-679632 util-mq-30582 DEBUG Received message of type 332 and size 296 Jul 06 16:55:03-679673 peerinfo-api-30582 DEBUG Received information about peer `QYYZ' from peerinfo database Jul 06 16:55:03-679710 rps-30582 DEBUG Got peer_id QYYZ from peerinfo Jul 06 16:55:03-679769 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-679815 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-679864 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-679915 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-679953 util-client-30582 DEBUG Received message of type 332 and size 296 from peerinfo Jul 06 16:55:03-679991 util-mq-30582 DEBUG Received message of type 332 and size 296 Jul 06 16:55:03-680032 peerinfo-api-30582 DEBUG Received information about peer `QYYZ' from peerinfo database Jul 06 16:55:03-680070 rps-30582 DEBUG Got peer_id QYYZ from peerinfo Jul 06 16:55:03-680378 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-680441 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-680489 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-680559 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-680599 util-client-30582 DEBUG Received message of type 332 and size 296 from peerinfo Jul 06 16:55:03-680637 util-mq-30582 DEBUG Received message of type 332 and size 296 Jul 06 16:55:03-680679 peerinfo-api-30582 DEBUG Received information about peer `QYYZ' from peerinfo database Jul 06 16:55:03-680756 rps-30582 DEBUG Got peer_id QYYZ from peerinfo Jul 06 16:55:03-680817 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-680860 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-680905 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-680956 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-680994 util-client-30582 DEBUG Received message of type 332 and size 296 from peerinfo Jul 06 16:55:03-681031 util-mq-30582 DEBUG Received message of type 332 and size 296 Jul 06 16:55:03-681071 peerinfo-api-30582 DEBUG Received information about peer `QYYZ' from peerinfo database Jul 06 16:55:03-681107 rps-30582 DEBUG Got peer_id QYYZ from peerinfo Jul 06 16:55:03-681161 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-681204 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-681247 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-681297 util-mst-30582 DEBUG MST receives 0 bytes with 588 bytes already in private buffer Jul 06 16:55:03-681335 util-client-30582 DEBUG Received message of type 332 and size 296 from peerinfo Jul 06 16:55:03-681372 util-mq-30582 DEBUG Received message of type 332 and size 296 Jul 06 16:55:03-681412 peerinfo-api-30582 DEBUG Received information about peer `QYYZ' from peerinfo database Jul 06 16:55:03-681448 rps-30582 DEBUG Got peer_id QYYZ from peerinfo Jul 06 16:55:03-681500 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-681543 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-681587 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-681634 util-mst-30582 DEBUG MST receives 0 bytes with 296 bytes already in private buffer Jul 06 16:55:03-681673 util-client-30582 DEBUG Received message of type 332 and size 296 from peerinfo Jul 06 16:55:03-681710 util-mq-30582 DEBUG Received message of type 332 and size 296 Jul 06 16:55:03-681748 peerinfo-api-30582 DEBUG Received information about peer `QYYZ' from peerinfo database Jul 06 16:55:03-681785 rps-30582 DEBUG Got peer_id QYYZ from peerinfo Jul 06 16:55:03-681825 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-681873 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-681916 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-681959 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-682008 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-682050 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-682094 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-682142 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-682185 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-682228 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-682278 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-682321 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-682366 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-682416 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-682458 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-682502 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-682555 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-682598 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-682678 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-682727 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-682770 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-682814 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-682866 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-682910 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-682959 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-683014 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-683062 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-683110 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-683166 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-683212 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-683261 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-683316 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-683359 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-683407 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-683461 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-683505 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-683553 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-683740 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-core.sock Jul 06 16:55:03-683782 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-core.sock' with default (null) Jul 06 16:55:03-683829 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-683869 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-683910 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-683949 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-683988 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-684026 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-684195 util-client-30582 DEBUG Failed to establish connection to `core', no further addresses to try, will try again in 64 ms. Jul 06 16:55:03-684256 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-684307 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-684371 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-684436 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-684483 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-684533 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-684589 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-684638 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-684698 util-mq-30582 DEBUG sending message of type 1024 from queue Jul 06 16:55:03-684752 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-684797 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:03-714670 util-mst-30582 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Jul 06 16:55:03-714840 util-mst-30582 DEBUG MST receives 0 bytes with 108 bytes already in private buffer Jul 06 16:55:03-714886 util-client-30582 DEBUG Received message of type 1024 and size 108 from cadet Jul 06 16:55:03-714972 util-mq-30582 DEBUG Received message of type 1024 and size 108 Jul 06 16:55:03-715036 cadet-api-30582 DEBUG Creating incoming channel 0 [RNN0WW1R] 0x17d20c0 Jul 06 16:55:03-715080 rps-30582 DEBUG New channel was established to us (Peer QYYZ). Jul 06 16:55:03-715123 rps-30582 DEBUG Peer QYYZ is online and valid, calling 2 pending operations on it Jul 06 16:55:03-715161 rps-30582 DEBUG Removing pending online check for peer QYYZ Jul 06 16:55:03-715199 rps-30582 DEBUG Updating samplers with peer QYYZ from insert_in_sampler() Jul 06 16:55:03-715413 rps-sampler_elem-30582 DEBUG Got PeerID QYYZ; Simply accepting (was empty previously). Jul 06 16:55:03-715488 rps-sampler_elem-30582 DEBUG Got PeerID QYYZ; Simply accepting (was empty previously). Jul 06 16:55:03-715556 rps-sampler_elem-30582 DEBUG Got PeerID QYYZ; Simply accepting (was empty previously). Jul 06 16:55:03-715621 rps-sampler_elem-30582 DEBUG Got PeerID QYYZ; Simply accepting (was empty previously). Jul 06 16:55:03-715687 rps-sampler_elem-30582 DEBUG Got PeerID QYYZ; Simply accepting (was empty previously). Jul 06 16:55:03-715753 rps-sampler_elem-30582 DEBUG Got PeerID QYYZ; Simply accepting (was empty previously). Jul 06 16:55:03-715818 rps-sampler_elem-30582 DEBUG Got PeerID QYYZ; Simply accepting (was empty previously). Jul 06 16:55:03-715883 rps-sampler_elem-30582 DEBUG Got PeerID QYYZ; Simply accepting (was empty previously). Jul 06 16:55:03-715949 rps-sampler_elem-30582 DEBUG Got PeerID QYYZ; Simply accepting (was empty previously). Jul 06 16:55:03-716014 rps-sampler_elem-30582 DEBUG Got PeerID QYYZ; Simply accepting (was empty previously). Jul 06 16:55:03-716052 rps-sampler_common-30582 DEBUG Calling callbacks waiting for update notification. Jul 06 16:55:03-716102 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:03-716157 rps-30582 DEBUG Got peer (QYYZ) from biased stream - update all clients Jul 06 16:55:03-716204 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-716263 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-716325 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-716382 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-716439 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-716492 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-716543 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-716599 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-716648 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-716698 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-716752 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-716809 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-719345 util-mst-30582 DEBUG MST receives 0 bytes with 232 bytes already in private buffer Jul 06 16:55:03-719454 util-client-30582 DEBUG Received message of type 332 and size 128 from peerinfo Jul 06 16:55:03-719497 util-mq-30582 DEBUG Received message of type 332 and size 128 Jul 06 16:55:03-719542 peerinfo-api-30582 DEBUG Received information about peer `3969' from peerinfo database Jul 06 16:55:03-719582 rps-30582 DEBUG Got peer_id 3969 from peerinfo Jul 06 16:55:03-719637 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:03-719683 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-719722 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-719764 peerinfo-api-30582 DEBUG Received information about peer `0MJS' from peerinfo database Jul 06 16:55:03-719802 rps-30582 DEBUG Got peer_id 0MJS from peerinfo Jul 06 16:55:03-719845 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-719950 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-720014 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-720075 util-mst-30582 DEBUG MST receives 0 bytes with 104 bytes already in private buffer Jul 06 16:55:03-720115 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-720154 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-720196 peerinfo-api-30582 DEBUG Received information about peer `ZVMT' from peerinfo database Jul 06 16:55:03-720237 rps-30582 DEBUG Got peer_id ZVMT from peerinfo Jul 06 16:55:03-720285 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-720342 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-720395 util-mst-30582 DEBUG MST receives 0 bytes with 104 bytes already in private buffer Jul 06 16:55:03-720435 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-720474 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-720514 peerinfo-api-30582 DEBUG Received information about peer `QWNV' from peerinfo database Jul 06 16:55:03-720552 rps-30582 DEBUG Got peer_id QWNV from peerinfo Jul 06 16:55:03-720594 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-720657 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-720709 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-720767 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:03-720825 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-720872 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-748366 util-30582 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-core.sock Jul 06 16:55:03-748517 util-30582 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-core.sock' with default (null) Jul 06 16:55:03-748570 util-30582 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Jul 06 16:55:03-748611 util-30582 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Jul 06 16:55:03-748650 util-30582 DEBUG Asked to $-expand ${TMP:-/tmp} Jul 06 16:55:03-748689 util-30582 DEBUG Split into `TMP' and `' with default /tmp Jul 06 16:55:03-748728 util-30582 DEBUG Asked to $-expand /tmp Jul 06 16:55:03-748763 util-30582 DEBUG Doesn't start with $ - not expanding Jul 06 16:55:03-748899 util-client-30582 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-core.sock'! Jul 06 16:55:03-748984 util-client-30582 DEBUG message of type 64 trying to send with socket 0x17d5480 (MQ: 0x17ce6a0 Jul 06 16:55:03-749036 util-client-30582 DEBUG sending message of type 64 successful Jul 06 16:55:03-749532 util-mst-30582 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Jul 06 16:55:03-749634 util-mst-30582 DEBUG MST receives 0 bytes with 40 bytes already in private buffer Jul 06 16:55:03-749676 util-client-30582 DEBUG Received message of type 65 and size 40 from core Jul 06 16:55:03-749715 util-mq-30582 DEBUG Received message of type 65 and size 40 Jul 06 16:55:03-749772 core-api-30582 DEBUG Connected to core service of peer `QYYZ'. Jul 06 16:55:03-749825 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-765759 util-mst-30582 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Jul 06 16:55:03-765908 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:03-765955 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:03-766005 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001 (peer QYYZ); new window size is 1! Jul 06 16:55:03-766056 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-766164 rps-30582 DEBUG Sending message on channel QYYZ to CADET, new window size is 0 Jul 06 16:55:03-766206 util-mq-30582 DEBUG sending message of type 1020, queue empty (MQ: 0x17cf158) Jul 06 16:55:03-766268 util-client-30582 DEBUG message of type 1020 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:03-766318 util-client-30582 DEBUG sending message of type 1020 successful Jul 06 16:55:03-811977 util-mst-30582 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Jul 06 16:55:03-812104 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:03-812146 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:03-812193 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001 (peer QYYZ); new window size is 1! Jul 06 16:55:03-812232 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001, allow send now 1! Jul 06 16:55:03-812269 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-858072 util-mst-30582 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Jul 06 16:55:03-858210 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:03-858255 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:03-858304 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001 (peer QYYZ); new window size is 2! Jul 06 16:55:03-858344 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001, allow send now 2! Jul 06 16:55:03-858381 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-864070 util-mst-30582 DEBUG MST receives 0 bytes with 32 bytes already in private buffer Jul 06 16:55:03-864213 util-client-30582 DEBUG Received message of type 323 and size 32 from nse Jul 06 16:55:03-864256 util-mq-30582 DEBUG Received message of type 323 and size 32 Jul 06 16:55:03-864308 rps-30582 DEBUG Received a ns estimate - logest: 0.000000, std_dev: nan (old_size: 10) Jul 06 16:55:03-864350 rps-30582 DEBUG Not using estimate 1.000000 Jul 06 16:55:03-864399 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:03-864440 rps-30582 DEBUG sampler_size is now 10 Jul 06 16:55:03-864482 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-864543 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-864595 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-865009 util-mst-30582 DEBUG MST receives 0 bytes with 32 bytes already in private buffer Jul 06 16:55:03-865073 util-client-30582 DEBUG Received message of type 323 and size 32 from nse Jul 06 16:55:03-865112 util-mq-30582 DEBUG Received message of type 323 and size 32 Jul 06 16:55:03-865155 rps-30582 DEBUG Received a ns estimate - logest: 0.000000, std_dev: nan (old_size: 10) Jul 06 16:55:03-865196 rps-30582 DEBUG Not using estimate 1.000000 Jul 06 16:55:03-865243 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:03-865283 rps-30582 DEBUG sampler_size is now 10 Jul 06 16:55:03-865323 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-865379 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-865430 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-871242 util-mst-30582 DEBUG MST receives 0 bytes with 164 bytes already in private buffer Jul 06 16:55:03-871360 util-client-30582 DEBUG Received message of type 332 and size 164 from peerinfo Jul 06 16:55:03-871402 util-mq-30582 DEBUG Received message of type 332 and size 164 Jul 06 16:55:03-871446 peerinfo-api-30582 DEBUG Received information about peer `5WBG' from peerinfo database Jul 06 16:55:03-871486 rps-30582 DEBUG Got peer_id 5WBG from peerinfo Jul 06 16:55:03-871540 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:03-871583 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-871696 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-871752 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-904993 util-mst-30582 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Jul 06 16:55:03-905125 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:03-905170 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:03-905217 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001 (peer QYYZ); new window size is 3! Jul 06 16:55:03-905256 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001, allow send now 3! Jul 06 16:55:03-905293 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-950843 util-mst-30582 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Jul 06 16:55:03-950994 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:03-951041 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:03-951087 cadet-api-30582 DEBUG Got an ACK on mq channel 0 (peer QYYZ); new window size is 1! Jul 06 16:55:03-951127 cadet-api-30582 DEBUG Got an ACK on mq channel 0, allow send now 1! Jul 06 16:55:03-951165 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-966641 util-mst-30582 DEBUG MST receives 0 bytes with 104 bytes already in private buffer Jul 06 16:55:03-966792 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-966838 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-966883 peerinfo-api-30582 DEBUG Received information about peer `N97R' from peerinfo database Jul 06 16:55:03-966925 rps-30582 DEBUG Got peer_id N97R from peerinfo Jul 06 16:55:03-966977 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:03-967020 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-967087 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-967134 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-969280 util-mst-30582 DEBUG MST receives 0 bytes with 104 bytes already in private buffer Jul 06 16:55:03-969412 util-client-30582 DEBUG Received message of type 332 and size 104 from peerinfo Jul 06 16:55:03-969454 util-mq-30582 DEBUG Received message of type 332 and size 104 Jul 06 16:55:03-969497 peerinfo-api-30582 DEBUG Received information about peer `P54S' from peerinfo database Jul 06 16:55:03-969537 rps-30582 DEBUG Got peer_id P54S from peerinfo Jul 06 16:55:03-969588 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:03-969632 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:03-969694 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:03-969740 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:03-996804 util-mst-30582 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Jul 06 16:55:03-996938 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:03-996980 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:03-997027 cadet-api-30582 DEBUG Got an ACK on mq channel 0 (peer QYYZ); new window size is 2! Jul 06 16:55:03-997065 cadet-api-30582 DEBUG Got an ACK on mq channel 0, allow send now 2! Jul 06 16:55:03-997102 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:04-042318 util-mst-30582 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Jul 06 16:55:04-042491 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:04-042546 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:04-042594 cadet-api-30582 DEBUG Got an ACK on mq channel 0 (peer QYYZ); new window size is 3! Jul 06 16:55:04-042633 cadet-api-30582 DEBUG Got an ACK on mq channel 0, allow send now 3! Jul 06 16:55:04-042719 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:04-088668 util-mst-30582 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Jul 06 16:55:04-088838 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:04-088895 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:04-088949 cadet-api-30582 DEBUG Got an ACK on mq channel 0 (peer QYYZ); new window size is 4! Jul 06 16:55:04-088990 cadet-api-30582 DEBUG Got an ACK on mq channel 0, allow send now 4! Jul 06 16:55:04-089028 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:04-252359 util-mst-30582 DEBUG MST receives 0 bytes with 40 bytes already in private buffer Jul 06 16:55:04-252519 util-client-30582 DEBUG Received message of type 67 and size 40 from core Jul 06 16:55:04-252564 util-mq-30582 DEBUG Received message of type 67 and size 40 Jul 06 16:55:04-252608 core-api-30582 DEBUG Received notification about connection from `5WBG'. Jul 06 16:55:04-252676 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:04-296900 util-mst-30582 DEBUG MST receives 0 bytes with 40 bytes already in private buffer Jul 06 16:55:04-297051 util-client-30582 DEBUG Received message of type 67 and size 40 from core Jul 06 16:55:04-297096 util-mq-30582 DEBUG Received message of type 67 and size 40 Jul 06 16:55:04-297139 core-api-30582 DEBUG Received notification about connection from `3969'. Jul 06 16:55:04-297186 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:04-717163 util-mst-30582 DEBUG MST receives 0 bytes with 16 bytes already in private buffer Jul 06 16:55:04-717331 util-client-30582 DEBUG Received message of type 1020 and size 16 from cadet Jul 06 16:55:04-717385 util-mq-30582 DEBUG Received message of type 1020 and size 16 Jul 06 16:55:04-717435 cadet-api-30582 DEBUG Got a FWD data on channel QYYZ [0] of type 950 Jul 06 16:55:04-717486 util-mq-30582 DEBUG Received message of type 950 and size 4 Jul 06 16:55:04-717528 rps-30582 DEBUG Received CHECK_LIVE (QYYZ) Jul 06 16:55:04-717578 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:04-717633 cadet-api-30582 DEBUG Sending ACK on channel 0 Jul 06 16:55:04-717672 util-mq-30582 DEBUG sending message of type 1021, queue empty (MQ: 0x17cf158) Jul 06 16:55:04-717714 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:04-717788 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:04-717835 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:04-717881 util-client-30582 DEBUG message of type 1021 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:04-717927 util-client-30582 DEBUG sending message of type 1021 successful Jul 06 16:55:04-717991 util-mst-30582 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Jul 06 16:55:04-718032 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:04-718071 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:04-718114 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001 (peer QYYZ); new window size is 4! Jul 06 16:55:04-718152 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001, allow send now 4! Jul 06 16:55:04-718190 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:04-765061 util-mst-30582 DEBUG MST receives 0 bytes with 40 bytes already in private buffer Jul 06 16:55:04-765303 util-client-30582 DEBUG Received message of type 67 and size 40 from core Jul 06 16:55:04-765395 util-mq-30582 DEBUG Received message of type 67 and size 40 Jul 06 16:55:04-765481 core-api-30582 DEBUG Received notification about connection from `P54S'. Jul 06 16:55:04-765573 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:05-357401 util-mst-30582 DEBUG MST receives 0 bytes with 32 bytes already in private buffer Jul 06 16:55:05-357607 util-client-30582 DEBUG Received message of type 323 and size 32 from nse Jul 06 16:55:05-357655 util-mq-30582 DEBUG Received message of type 323 and size 32 Jul 06 16:55:05-357706 rps-30582 DEBUG Received a ns estimate - logest: 1.000000, std_dev: nan (old_size: 10) Jul 06 16:55:05-357749 rps-30582 DEBUG Not using estimate 1.259921 Jul 06 16:55:05-357798 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:05-357838 rps-30582 DEBUG sampler_size is now 10 Jul 06 16:55:05-357880 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:05-357944 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:05-357995 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:05-405348 util-mst-30582 DEBUG MST receives 0 bytes with 32 bytes already in private buffer Jul 06 16:55:05-405529 util-client-30582 DEBUG Received message of type 323 and size 32 from nse Jul 06 16:55:05-405580 util-mq-30582 DEBUG Received message of type 323 and size 32 Jul 06 16:55:05-405636 rps-30582 DEBUG Received a ns estimate - logest: 4.667253, std_dev: nan (old_size: 10) Jul 06 16:55:05-405681 rps-30582 DEBUG Not using estimate 2.939867 Jul 06 16:55:05-405732 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:05-405773 rps-30582 DEBUG sampler_size is now 10 Jul 06 16:55:05-405816 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:05-405882 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:05-405930 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:05-405982 util-mst-30582 DEBUG MST receives 0 bytes with 32 bytes already in private buffer Jul 06 16:55:05-406022 util-client-30582 DEBUG Received message of type 323 and size 32 from nse Jul 06 16:55:05-406060 util-mq-30582 DEBUG Received message of type 323 and size 32 Jul 06 16:55:05-406102 rps-30582 DEBUG Received a ns estimate - logest: 4.667253, std_dev: nan (old_size: 10) Jul 06 16:55:05-406143 rps-30582 DEBUG Not using estimate 2.939867 Jul 06 16:55:05-406186 rps-30582 DEBUG sampler_size is now 10 Jul 06 16:55:05-406226 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:05-406277 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:05-406333 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:05-406383 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:13-967921 util-mst-30582 DEBUG MST receives 0 bytes with 40 bytes already in private buffer Jul 06 16:55:13-968167 util-client-30582 DEBUG Received message of type 67 and size 40 from core Jul 06 16:55:13-968259 util-mq-30582 DEBUG Received message of type 67 and size 40 Jul 06 16:55:13-968346 core-api-30582 DEBUG Received notification about connection from `N97R'. Jul 06 16:55:13-968434 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:35-428571 util-mst-30582 DEBUG MST receives 0 bytes with 40 bytes already in private buffer Jul 06 16:55:35-428892 util-client-30582 DEBUG Received message of type 67 and size 40 from core Jul 06 16:55:35-429023 util-mq-30582 DEBUG Received message of type 67 and size 40 Jul 06 16:55:35-429122 core-api-30582 DEBUG Received notification about connection from `Y924'. Jul 06 16:55:35-429235 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:36-896920 rps-30582 DEBUG Going to execute next round. Jul 06 16:55:36-897144 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:36-897218 rps-30582 DEBUG QYYZ Jul 06 16:55:36-897368 rps-30582 DEBUG Going to send pushes to 1 (ceil (0.450000 * 1)) peers. Jul 06 16:55:36-897433 rps-30582 DEBUG Going to send PUSH to peer QYYZ. Jul 06 16:55:36-897484 rps-30582 DEBUG Sending message to QYYZ of type PUSH Jul 06 16:55:36-897537 util-mq-30582 DEBUG sending message of type 951, queue empty (MQ: 0x17d1188) Jul 06 16:55:36-897668 rps-30582 DEBUG Going to send pulls to 1 (ceil (0.450000 * 1)) peers. Jul 06 16:55:36-897725 rps-30582 DEBUG Going to send PULL REQUEST to peer QYYZ. Jul 06 16:55:36-897772 rps-30582 DEBUG Sending message to QYYZ of type PULL REQUEST Jul 06 16:55:36-897824 rps-30582 DEBUG No update of the view. Jul 06 16:55:36-897897 rps-30582 DEBUG Received 0 pushes and 0 pulls last round (alpha (0.45) * view_size (sub->view1) = 0.45) Jul 06 16:55:36-897963 rps-30582 DEBUG Finished round Jul 06 16:55:36-898044 rps-30582 DEBUG Sending message on channel QYYZ to CADET, new window size is 3 Jul 06 16:55:36-898089 util-mq-30582 DEBUG sending message of type 1020, queue empty (MQ: 0x17cf158) Jul 06 16:55:36-898138 rps-30582 DEBUG PUSH was sent. Jul 06 16:55:36-898192 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-898275 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-898393 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-898449 util-mq-30582 DEBUG sending message of type 952 from queue Jul 06 16:55:36-898499 util-client-30582 DEBUG message of type 1020 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:36-898561 util-client-30582 DEBUG sending message of type 1020 successful Jul 06 16:55:36-898628 rps-30582 DEBUG Sending message on channel QYYZ to CADET, new window size is 2 Jul 06 16:55:36-898677 util-mq-30582 DEBUG sending message of type 1020, queue empty (MQ: 0x17cf158) Jul 06 16:55:36-898726 rps-30582 DEBUG PULL REQUEST was sent. Jul 06 16:55:36-898783 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-898839 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-898901 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-898953 util-client-30582 DEBUG message of type 1020 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:36-899007 util-client-30582 DEBUG sending message of type 1020 successful Jul 06 16:55:36-899070 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-899125 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-899185 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-899253 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-899309 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-899373 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-899435 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-899487 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-899541 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-899604 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-899657 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-899717 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-899780 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-899834 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-899892 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-899955 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-900018 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-900076 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-900137 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-900196 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-900265 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-900392 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-900445 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-900500 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-900571 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-900621 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-900674 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-900733 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-900792 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-900875 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-900949 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-900998 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-901488 util-mst-30582 DEBUG MST receives 0 bytes with 48 bytes already in private buffer Jul 06 16:55:36-901637 util-client-30582 DEBUG Received message of type 1020 and size 16 from cadet Jul 06 16:55:36-901694 util-mq-30582 DEBUG Received message of type 1020 and size 16 Jul 06 16:55:36-901750 cadet-api-30582 DEBUG Got a FWD data on channel QYYZ [0] of type 951 Jul 06 16:55:36-901801 util-mq-30582 DEBUG Received message of type 951 and size 4 Jul 06 16:55:36-901845 rps-30582 DEBUG Received PUSH (QYYZ) Jul 06 16:55:36-901898 util-mq-30582 DEBUG sending message of type 168, queue empty (MQ: 0x17d1bb0) Jul 06 16:55:36-901962 cadet-api-30582 DEBUG Sending ACK on channel 0 Jul 06 16:55:36-902006 util-mq-30582 DEBUG sending message of type 1021, queue empty (MQ: 0x17cf158) Jul 06 16:55:36-902050 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:36-902092 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:36-902138 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001 (peer QYYZ); new window size is 3! Jul 06 16:55:36-902178 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001, allow send now 3! Jul 06 16:55:36-902218 util-client-30582 DEBUG Received message of type 1020 and size 16 from cadet Jul 06 16:55:36-902257 util-mq-30582 DEBUG Received message of type 1020 and size 16 Jul 06 16:55:36-902300 cadet-api-30582 DEBUG Got a FWD data on channel QYYZ [0] of type 952 Jul 06 16:55:36-902340 util-mq-30582 DEBUG Received message of type 952 and size 4 Jul 06 16:55:36-902380 rps-30582 DEBUG Received PULL REQUEST (QYYZ) Jul 06 16:55:36-902428 cadet-api-30582 DEBUG Sending ACK on channel 0 Jul 06 16:55:36-902470 rps-30582 DEBUG Going to send PULL REPLY with 1 peers to QYYZ Jul 06 16:55:36-902537 rps-30582 DEBUG Sending message to QYYZ of type PULL REPLY Jul 06 16:55:36-902580 util-mq-30582 DEBUG sending message of type 953, queue empty (MQ: 0x17d1188) Jul 06 16:55:36-902630 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:36-902670 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:36-902713 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001 (peer QYYZ); new window size is 4! Jul 06 16:55:36-902754 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:36-902820 rps-30582 DEBUG Sending message on channel QYYZ to CADET, new window size is 3 Jul 06 16:55:36-902863 rps-30582 DEBUG PULL REPLY was sent. Jul 06 16:55:36-902913 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-902969 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-903025 util-client-30582 DEBUG message of type 1021 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:36-903217 util-client-30582 DEBUG sending message of type 1021 successful Jul 06 16:55:36-903302 util-mq-30582 DEBUG sending message of type 1021 from queue Jul 06 16:55:36-903436 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-903504 util-client-30582 DEBUG message of type 1021 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:36-903796 util-client-30582 DEBUG sending message of type 1021 successful Jul 06 16:55:36-903873 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-903922 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-903978 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-904022 util-mq-30582 DEBUG sending message of type 1020 from queue Jul 06 16:55:36-904079 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-904126 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-904172 util-client-30582 DEBUG message of type 1020 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:36-904413 util-client-30582 DEBUG sending message of type 1020 successful Jul 06 16:55:36-904522 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-904584 util-mst-30582 DEBUG MST receives 0 bytes with 60 bytes already in private buffer Jul 06 16:55:36-904639 util-client-30582 DEBUG Received message of type 1020 and size 52 from cadet Jul 06 16:55:36-904682 util-mq-30582 DEBUG Received message of type 1020 and size 52 Jul 06 16:55:36-904739 cadet-api-30582 DEBUG Got a FWD data on channel QYYZ [0] of type 953 Jul 06 16:55:36-904783 util-mq-30582 DEBUG Received message of type 953 and size 40 Jul 06 16:55:36-904834 rps-30582 DEBUG Received PULL REPLY (QYYZ) Jul 06 16:55:36-904878 rps-30582 DEBUG PULL REPLY received, got following 1 peers: Jul 06 16:55:36-904918 rps-30582 DEBUG 0. QYYZ Jul 06 16:55:36-904973 cadet-api-30582 DEBUG Sending ACK on channel 0 Jul 06 16:55:36-905014 util-mq-30582 DEBUG sending message of type 1021, queue empty (MQ: 0x17cf158) Jul 06 16:55:36-905057 util-client-30582 DEBUG Received message of type 1021 and size 8 from cadet Jul 06 16:55:36-905098 util-mq-30582 DEBUG Received message of type 1021 and size 8 Jul 06 16:55:36-905144 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001 (peer QYYZ); new window size is 4! Jul 06 16:55:36-905185 cadet-api-30582 DEBUG Got an ACK on mq channel 80000001, allow send now 4! Jul 06 16:55:36-905236 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:36-905312 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-905364 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-905417 util-client-30582 DEBUG message of type 1021 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:36-905825 util-client-30582 DEBUG sending message of type 1021 successful Jul 06 16:55:36-905900 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-905958 util-mst-30582 DEBUG MST receives 0 bytes with 120 bytes already in private buffer Jul 06 16:55:36-906000 util-client-30582 DEBUG Received message of type 332 and size 40 from peerinfo Jul 06 16:55:36-906040 util-mq-30582 DEBUG Received message of type 332 and size 40 Jul 06 16:55:36-906080 util-client-30582 DEBUG Received message of type 332 and size 80 from peerinfo Jul 06 16:55:36-906120 util-mq-30582 DEBUG Received message of type 332 and size 80 Jul 06 16:55:36-906165 peerinfo-api-30582 DEBUG Received information about peer `ZXSZ' from peerinfo database Jul 06 16:55:36-906205 rps-30582 DEBUG Got peer_id ZXSZ from peerinfo Jul 06 16:55:36-906264 rps-30582 DEBUG Get informed about peer ZXSZ getting online Jul 06 16:55:36-906307 rps-30582 DEBUG Trying to establish channel to peer ZXSZ Jul 06 16:55:36-906350 rps-30582 DEBUG Creating channel to peer ZXSZ at port RNN0WW1R Jul 06 16:55:36-906399 util-mq-30582 DEBUG sending message of type 1024, queue empty (MQ: 0x17cf158) Jul 06 16:55:36-906443 util-mq-30582 DEBUG sending message of type 950, queue empty (MQ: 0x17e2dc8) Jul 06 16:55:36-906552 util-mst-30582 DEBUG Server-mst leaves 0 bytes in private buffer Jul 06 16:55:36-906637 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-906694 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-906751 util-client-30582 DEBUG message of type 1024 trying to send with socket 0x17d0798 (MQ: 0x17cf158 Jul 06 16:55:36-923649 util-client-30582 DEBUG sending message of type 1024 successful Jul 06 16:55:36-923848 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-923954 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-924023 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-924083 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-924146 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-924206 util-client-30582 DEBUG sending message of type 168 successful Jul 06 16:55:36-924264 util-mq-30582 DEBUG sending message of type 168 from queue Jul 06 16:55:36-924323 util-client-30582 DEBUG message of type 168 trying to send with socket 0x17ce918 (MQ: 0x17d1bb0 Jul 06 16:55:36-924380 util-client-30582 DEBUG sending message of type 168 successful gnunet.user.conf (165 bytes)
[arm] #GLOBAL_POSTFIX = -l $GNUNET_HOME/logs/{}-logs -L ERROR #OPTIONS = -l $GNUNET_HOME/logs/arm-logs -L ERROR START_SYSTEM_SERVICES = NO START_USER_SERVICES = YES gnunet.conf (314 bytes)
[arm] GLOBAL_POSTFIX = -L ERROR START_SYSTEM_SERVICES = YES START_USER_SERVICES = NO [ats] WAN_QUOTA_IN = unlimited WAN_QUOTA_OUT = unlimited [transport] PLUGINS = tcp [fs] DISABLE_ANON_TRANSFER = YES [exit] OPTIONS = -L DEBUG START_ON_DEMAND = YES [hellognunet.gnunet.] TCP_REDIRECTS = 80:169.254.86.1:8080 | ||||
|
In NixOS, the multi-user setup now works for me (except for the problem described in https://bugs.gnunet.org/view.php?id=5795). The runtime directory for my user is created as soon as I run gnunet-arm -s as my user. But in your case it seems that is not possible. The log you attached is from the user services, correct? Is there suspicious output in the system services logs? |
|
---> Start `gnunet-arm -s` as normal user. Maybe this information was missing! I didn't know I had to start gnunet-arm also as normal user as well. In the handbook in chapter 4.7.1 it says only in the last sentence: "For the multi-user setup first the system services need to be started as the system user, i.e. the user gnunet needs to execute gnunet-arm -s. This should be done by the system’s init system." Is this correct? |
|
@lurchi: To answere your questions. Yes, it is possible to start as normal user. Yes, the logs are from the user services without having started gnunet-arm under normal user. I supposed running gnunet-arm under system user "gnunet" was enought. No suspicous output in the system service logs. |
|
The information that normal users have to run gnunet-arm -s is in the manual, but hidden in the "Config Leftovers" chapter which we should slowly eliminate. I added it in the "Checking the installation chapter" too: https://git.gnunet.org/gnunet.git/commit/?id=9ffc488dd37caebe53ce4af86fb1a3f0eacc7c7c Can this issue be closed? |
Date Modified | Username | Field | Change |
---|---|---|---|
2019-07-06 17:02 | xrs | New Issue | |
2019-07-06 17:02 | xrs | File Added: gnunet-idedentity.log | |
2019-07-06 17:02 | xrs | File Added: gnunet-publish.log | |
2019-07-06 17:02 | xrs | File Added: gnunet-2019-07-06.log | |
2019-07-06 17:02 | xrs | File Added: gnunet.user.conf | |
2019-07-06 17:02 | xrs | File Added: gnunet.conf | |
2019-07-07 02:22 | lurchi | Note Added: 0014653 | |
2019-07-07 11:43 | xrs | Note Added: 0014654 | |
2019-07-07 11:47 | xrs | Note Added: 0014655 | |
2019-07-07 12:32 | lurchi | Note Added: 0014656 | |
2019-07-07 13:02 | xrs | Assigned To | => lurchi |
2019-07-07 13:02 | xrs | Status | new => assigned |
2019-07-07 13:03 | xrs | Status | assigned => resolved |
2019-07-07 13:03 | xrs | Resolution | open => fixed |
2019-07-24 20:41 | Christian Grothoff | Fixed in Version | => 0.11.6 |
2019-07-24 20:42 | Christian Grothoff | Status | resolved => closed |