================================================ gnunet 0.11.0pre66: src/arm/test-suite.log ================================================ # TOTAL: 4 # PASS: 3 # SKIP: 0 # XFAIL: 0 # FAIL: 1 # XPASS: 0 # ERROR: 0 .. contents:: :depth: 2 FAIL: test_gnunet_service_arm ============================= Feb 22 21:43:24-792702 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 22 21:43:24-792929 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 22 21:43:24-793024 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 22 21:43:24-793081 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 22 21:43:24-793109 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 22 21:43:24-793160 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 22 21:43:24-793194 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 22 21:43:24-793246 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 22 21:43:24-793299 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 22 21:43:24-793347 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 22 21:43:24-793369 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 22 21:43:24-793426 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 22 21:43:24-793474 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 22 21:43:24-793534 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 22 21:43:24-793553 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 22 21:43:24-793604 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 22 21:43:24-793643 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 22 21:43:24-793687 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 22 21:43:24-793723 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 22 21:43:24-793773 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 22 21:43:24-793797 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 22 21:43:24-793841 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 22 21:43:24-793923 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 22 21:43:24-793969 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 22 21:43:24-794010 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 22 21:43:24-794054 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 22 21:43:24-794082 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 22 21:43:24-794134 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 22 21:43:24-794304 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 22 21:43:24-794353 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 22 21:43:24-794370 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 22 21:43:24-794414 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 22 21:43:24-794443 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 22 21:43:24-794492 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 22 21:43:24-794640 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 22 21:43:24-794699 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 22 21:43:24-794786 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 22 21:43:24-794835 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 22 21:43:24-794884 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 22 21:43:24-794929 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 22 21:43:24-794964 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 22 21:43:24-795012 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 22 21:43:24-795048 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 22 21:43:24-795096 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 22 21:43:24-795116 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 22 21:43:24-795161 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 22 21:43:24-795184 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 22 21:43:24-795240 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 22 21:43:24-795280 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 22 21:43:24-795326 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 22 21:43:24-795369 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 22 21:43:24-795436 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 22 21:43:24-795492 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 22 21:43:24-795562 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 22 21:43:24-795643 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 22 21:43:24-795711 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 22 21:43:24-795783 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 22 21:43:24-795847 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 22 21:43:24-795877 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 22 21:43:24-795921 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 22 21:43:24-795947 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 22 21:43:24-795997 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 22 21:43:24-796034 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 22 21:43:24-796078 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 22 21:43:24-796109 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 22 21:43:24-796160 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 22 21:43:24-796193 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 22 21:43:24-796238 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 22 21:43:24-796291 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 22 21:43:24-796362 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 22 21:43:24-796405 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 22 21:43:24-796460 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 22 21:43:24-796499 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 22 21:43:24-796545 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 22 21:43:24-796623 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 22 21:43:24-796687 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 22 21:43:24-796751 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 22 21:43:24-796801 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 22 21:43:24-796831 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 22 21:43:24-796882 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 22 21:43:24-796913 util-12645 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 22 21:43:24-796961 util-12645 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 22 21:43:24-796994 util-12645 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 22 21:43:24-797044 util-12645 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 22 21:43:24-797056 util-12645 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 22 21:43:24-797111 util-12645 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 22 21:43:24-797153 util-12645 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 22 21:43:24-797206 util-12645 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 22 21:43:24-797333 util-scheduler-12645 DEBUG Registering signal handlers Feb 22 21:43:24-797380 util-scheduler-12645 DEBUG Adding task 0x7e716131e080 Feb 22 21:43:24-797402 util-scheduler-12645 DEBUG Adding continuation task 0x7e716131e160 Feb 22 21:43:24-797416 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-797436 util-scheduler-12645 DEBUG Running task 0x7e716131e080 Feb 22 21:43:24-797447 util-os-priority-12645 DEBUG Not installing a handler because $GNUNET_OS_CONTROL_PIPE is empty Feb 22 21:43:24-797461 util-scheduler-12645 DEBUG destroying task 0x7e716131e080 Feb 22 21:43:24-797470 util-scheduler-12645 DEBUG Running task 0x7e716131e160 Feb 22 21:43:24-797492 util-speedup-12645 DEBUG Speed up disabled Feb 22 21:43:24-797503 util-scheduler-12645 DEBUG Adding shutdown task 0x7e716131e080 Feb 22 21:43:24-797526 util-12645 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Feb 22 21:43:24-797537 util-12645 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Feb 22 21:43:24-797547 util-12645 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Feb 22 21:43:24-797557 util-12645 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-797567 util-12645 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-797576 util-12645 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-797592 util-12645 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Feb 22 21:43:24-797612 util-12645 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Feb 22 21:43:24-797623 util-12645 DEBUG Asked to $-expand ${USER:-user} Feb 22 21:43:24-797632 util-12645 DEBUG Split into `USER' and `' with default user Feb 22 21:43:24-797647 util-scheduler-12645 DEBUG Adding task 0x7e716131e1d0 Feb 22 21:43:24-797671 arm-api-12645 DEBUG Sending TEST message to ARM Feb 22 21:43:24-797684 util-mq-12645 DEBUG sending message of type 15, queue empty (MQ: 0x7e7161338150) Feb 22 21:43:24-797694 util-client-12645 DEBUG message of type 15 waiting for socket Feb 22 21:43:24-797709 arm-api-12645 DEBUG Starting service `arm' Feb 22 21:43:24-797721 arm-api-12645 DEBUG Starting ARM service Feb 22 21:43:24-797906 util-scheduler-12645 DEBUG Adding task 0x7e716131e240 Feb 22 21:43:24-797938 util-scheduler-12645 DEBUG destroying task 0x7e716131e160 Feb 22 21:43:24-797950 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-797966 util-scheduler-12645 DEBUG Running task 0x7e716131e240 Feb 22 21:43:24-797976 arm-api-12645 DEBUG Notifying client that we started the ARM service Feb 22 21:43:24-797987 test-gnunet-service-arm-12645 DEBUG Trying to resolve our own hostname! Feb 22 21:43:24-798008 util-resolver-api-12645 DEBUG Resolving our hostname `uptimegirl' Feb 22 21:43:24-798023 util-resolver-api-12645 DEBUG Trying to resolve hostname `uptimegirl'. Feb 22 21:43:24-798038 util-scheduler-12645 DEBUG Adding task 0x7e716131e2b0 Feb 22 21:43:24-798053 util-resolver-api-12645 DEBUG Will try to connect to DNS service in 1 ms Feb 22 21:43:24-798062 util-scheduler-12645 DEBUG Adding task 0x7e716131e320 Feb 22 21:43:24-798075 util-scheduler-12645 DEBUG destroying task 0x7e716131e240 Feb 22 21:43:24-798084 util-scheduler-12645 DEBUG Running task 0x7e716131e1d0 Feb 22 21:43:24-798099 util-12645 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Feb 22 21:43:24-798108 util-12645 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Feb 22 21:43:24-798119 util-12645 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Feb 22 21:43:24-798128 util-12645 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-798139 util-12645 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-798148 util-12645 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-798159 util-12645 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Feb 22 21:43:24-798168 util-12645 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Feb 22 21:43:24-798178 util-12645 DEBUG Asked to $-expand ${USER:-user} Feb 22 21:43:24-798187 util-12645 DEBUG Split into `USER' and `' with default user Feb 22 21:43:24-798237 util-client-12645 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 2 ms. Feb 22 21:43:24-798262 util-scheduler-12645 DEBUG Adding task 0x7e716131e240 Feb 22 21:43:24-798276 util-scheduler-12645 DEBUG destroying task 0x7e716131e1d0 Feb 22 21:43:24-798294 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-803216 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 22 21:43:24-803492 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 22 21:43:24-803614 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 22 21:43:24-803690 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 22 21:43:24-803747 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 22 21:43:24-803813 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 22 21:43:24-803850 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 22 21:43:24-803918 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 22 21:43:24-804002 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 22 21:43:24-804067 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 22 21:43:24-804100 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 22 21:43:24-804162 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 22 21:43:24-804211 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 22 21:43:24-804275 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 22 21:43:24-804296 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 22 21:43:24-804358 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 22 21:43:24-804410 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 22 21:43:24-804475 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 22 21:43:24-804520 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 22 21:43:24-804585 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 22 21:43:24-804621 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 22 21:43:24-804685 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 22 21:43:24-804792 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 22 21:43:24-804855 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 22 21:43:24-804914 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 22 21:43:24-804977 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 22 21:43:24-805013 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 22 21:43:24-805077 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 22 21:43:24-805296 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 22 21:43:24-805366 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 22 21:43:24-805387 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 22 21:43:24-805450 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 22 21:43:24-805492 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 22 21:43:24-805557 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 22 21:43:24-805697 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 22 21:43:24-805760 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 22 21:43:24-805878 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 22 21:43:24-805946 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 22 21:43:24-806007 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 22 21:43:24-806073 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 22 21:43:24-806132 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 22 21:43:24-806213 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 22 21:43:24-806281 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 22 21:43:24-806346 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 22 21:43:24-806377 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 22 21:43:24-806442 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 22 21:43:24-806472 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 22 21:43:24-806541 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 22 21:43:24-806599 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 22 21:43:24-806662 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 22 21:43:24-806702 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 22 21:43:24-806766 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 22 21:43:24-806818 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 22 21:43:24-806883 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 22 21:43:24-806946 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 22 21:43:24-807018 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 22 21:43:24-807075 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 22 21:43:24-807127 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 22 21:43:24-807148 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 22 21:43:24-807186 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 22 21:43:24-807205 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 22 21:43:24-807243 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 22 21:43:24-807268 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 22 21:43:24-807306 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 22 21:43:24-807329 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 22 21:43:24-807366 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 22 21:43:24-807392 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 22 21:43:24-807449 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 22 21:43:24-807516 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 22 21:43:24-807576 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 22 21:43:24-807627 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 22 21:43:24-807685 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 22 21:43:24-807726 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 22 21:43:24-807785 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 22 21:43:24-807866 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 22 21:43:24-807927 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 22 21:43:24-808011 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 22 21:43:24-808090 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 22 21:43:24-808127 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 22 21:43:24-808192 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 22 21:43:24-808228 util-9890 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 22 21:43:24-808285 util-9890 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 22 21:43:24-808325 util-9890 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 22 21:43:24-808387 util-9890 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 22 21:43:24-808404 util-9890 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 22 21:43:24-808491 util-9890 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 22 21:43:24-808558 util-9890 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 22 21:43:24-808643 util-9890 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 22 21:43:24-808843 util-9890 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Feb 22 21:43:24-808877 util-9890 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Feb 22 21:43:24-808896 util-9890 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Feb 22 21:43:24-808911 util-9890 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-808927 util-9890 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-808941 util-9890 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-808985 util-9890 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Feb 22 21:43:24-809000 util-9890 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Feb 22 21:43:24-809015 util-9890 DEBUG Asked to $-expand ${USER:-user} Feb 22 21:43:24-809028 util-9890 DEBUG Split into `USER' and `' with default user Feb 22 21:43:24-810685 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-810849 util-service-21510 DEBUG Service `arm' runs with configuration from `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 22 21:43:24-810973 util-scheduler-21510 DEBUG Registering signal handlers Feb 22 21:43:24-811038 util-scheduler-21510 DEBUG Adding task 0x788af8121080 Feb 22 21:43:24-811092 util-scheduler-21510 DEBUG Adding continuation task 0x788af81211d0 Feb 22 21:43:24-811116 util-scheduler-21510 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-811182 util-scheduler-21510 DEBUG Running task 0x788af8121080 Feb 22 21:43:24-811203 util-os-priority-21510 DEBUG Not installing a handler because $GNUNET_OS_CONTROL_PIPE is empty Feb 22 21:43:24-811293 util-scheduler-21510 DEBUG destroying task 0x788af8121080 Feb 22 21:43:24-811312 util-scheduler-21510 DEBUG Running task 0x788af81211d0 Feb 22 21:43:24-811893 util-scheduler-21510 DEBUG Adding shutdown task 0x788af8121240 Feb 22 21:43:24-811920 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-811957 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-811998 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812032 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812066 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812099 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812131 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812177 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812230 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812265 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812299 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812331 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812364 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812396 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812430 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812462 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812497 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812530 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812564 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812596 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812594 util-scheduler-12645 DEBUG Running task 0x7e716131e240 Feb 22 21:43:24-812633 util-12645 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Feb 22 21:43:24-812636 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812651 util-12645 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Feb 22 21:43:24-812673 util-12645 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Feb 22 21:43:24-812674 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812691 util-12645 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-812710 util-12645 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-812714 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812725 util-12645 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-812745 util-12645 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Feb 22 21:43:24-812749 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812759 util-12645 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Feb 22 21:43:24-812776 util-12645 DEBUG Asked to $-expand ${USER:-user} Feb 22 21:43:24-812787 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812791 util-12645 DEBUG Split into `USER' and `' with default user Feb 22 21:43:24-812820 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812839 util-client-12645 DEBUG Successfully connected to unixpath `/tmp/gnunet-ng0-runtime//gnunet-service-arm.sock'! Feb 22 21:43:24-812856 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812869 util-scheduler-12645 DEBUG destroying task 0x7e716131e240 Feb 22 21:43:24-812884 util-scheduler-12645 DEBUG Running task 0x7e716131e320 Feb 22 21:43:24-812891 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812899 util-resolver-api-12645 DEBUG Trying to connect to DNS service Feb 22 21:43:24-812919 util-12645 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-resolver.sock Feb 22 21:43:24-812924 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812933 util-12645 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-resolver.sock' with default (null) Feb 22 21:43:24-812950 util-12645 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 22 21:43:24-812959 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812964 util-12645 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-812982 util-12645 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-812994 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-812998 util-12645 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-813035 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-813068 util-scheduler-12645 DEBUG Adding task 0x7e716131e240 Feb 22 21:43:24-813072 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-813099 util-resolver-api-12645 DEBUG Transmitting DNS resolution request (ID 1) to DNS service Feb 22 21:43:24-813113 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-813120 util-mq-12645 DEBUG sending message of type 4, queue empty (MQ: 0x7e7161338270) Feb 22 21:43:24-813150 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-813194 util-client-12645 DEBUG message of type 4 waiting for socket Feb 22 21:43:24-813210 util-scheduler-12645 DEBUG destroying task 0x7e716131e320 Feb 22 21:43:24-813218 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-813226 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-813249 util-scheduler-12645 DEBUG Running task 0x7e716131e240 Feb 22 21:43:24-813265 util-12645 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-resolver.sock Feb 22 21:43:24-813267 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-813280 util-12645 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-resolver.sock' with default (null) Feb 22 21:43:24-813296 util-12645 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 22 21:43:24-813305 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-813311 util-12645 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-813328 util-12645 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-813342 util-12645 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-813382 util-21510 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-nat-auto.sock Feb 22 21:43:24-813388 util-resolver-api-12645 DEBUG Trying to resolve hostname `localhost'. Feb 22 21:43:24-813398 util-21510 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-nat-auto.sock' with default (null) Feb 22 21:43:24-813406 util-scheduler-12645 DEBUG Adding task 0x7e716131e470 Feb 22 21:43:24-813414 util-21510 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 22 21:43:24-813427 util-scheduler-12645 DEBUG destroying task 0x7e716131e240 Feb 22 21:43:24-813430 util-21510 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-813439 util-scheduler-12645 DEBUG Running task 0x7e716131e390 Feb 22 21:43:24-813447 util-21510 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-813454 util-client-12645 DEBUG message of type 15 trying to send with socket 0x7e7161347680 (MQ: 0x7e7161338150 Feb 22 21:43:24-813461 util-21510 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-813479 util-client-12645 DEBUG sending message of type 15 successful Feb 22 21:43:24-813495 util-scheduler-12645 DEBUG Adding task 0x7e716131e240 Feb 22 21:43:24-813508 util-scheduler-12645 DEBUG destroying task 0x7e716131e390 Feb 22 21:43:24-813528 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-813549 util-scheduler-12645 DEBUG Running task 0x7e716131e240 Feb 22 21:43:24-813565 util-scheduler-12645 DEBUG destroying task 0x7e716131e240 Feb 22 21:43:24-813582 util-scheduler-12645 DEBUG Running task 0x7e716131e470 Feb 22 21:43:24-813610 util-client-12645 DEBUG Trying to connect using address `::1:23355' Feb 22 21:43:24-813670 util-client-12645 DEBUG Trying to connect using address `127.0.0.1:23355' Feb 22 21:43:24-813713 util-resolver-api-12645 DEBUG Finished resolving hostname `localhost'. Feb 22 21:43:24-813729 util-scheduler-12645 DEBUG destroying task 0x7e716131e470 Feb 22 21:43:24-813748 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:29 2019 Feb 22 21:43:24-813768 util-scheduler-12645 DEBUG Running task 0x7e716131e240 Feb 22 21:43:24-813794 util-scheduler-12645 DEBUG destroying task 0x7e716131e240 Feb 22 21:43:24-813808 util-scheduler-12645 DEBUG Running task 0x7e716131e390 Feb 22 21:43:24-813832 util-client-12645 DEBUG Failed to establish connection to `resolver', no further addresses to try, will try again in 2 ms. Feb 22 21:43:24-813847 util-scheduler-12645 DEBUG Adding task 0x7e716131e240 Feb 22 21:43:24-813859 util-scheduler-12645 DEBUG destroying task 0x7e716131e390 Feb 22 21:43:24-813878 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-814112 arm-9890 INFO ARM now monitors connections to service `nat-auto' at `/tmp/gnunet-system-runtime//gnunet-service-nat-auto.sock' Feb 22 21:43:24-814160 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-814230 util-21510 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-nat.sock Feb 22 21:43:24-814248 util-21510 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-nat.sock' with default (null) Feb 22 21:43:24-814266 util-21510 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 22 21:43:24-814281 util-21510 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-814299 util-21510 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-814315 util-21510 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-814603 arm-9890 INFO ARM now monitors connections to service `nat' at `/tmp/gnunet-system-runtime//gnunet-service-nat.sock' Feb 22 21:43:24-814631 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-814673 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-814711 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-814753 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-814791 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-814830 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-814888 util-21510 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-statistics.sock Feb 22 21:43:24-814904 util-21510 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-statistics.sock' with default (null) Feb 22 21:43:24-814923 util-21510 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 22 21:43:24-814938 util-21510 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-814955 util-21510 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-814969 util-21510 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-815209 arm-9890 INFO ARM now monitors connections to service `statistics' at `/tmp/gnunet-system-runtime//gnunet-service-statistics.sock' Feb 22 21:43:24-815235 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-815348 util-21510 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-resolver.sock Feb 22 21:43:24-815366 util-21510 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-resolver.sock' with default (null) Feb 22 21:43:24-815382 util-21510 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 22 21:43:24-815397 util-21510 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-815414 util-21510 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-815429 util-21510 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-815662 arm-9890 INFO ARM now monitors connections to service `resolver' at `/tmp/gnunet-system-runtime//gnunet-service-resolver.sock' Feb 22 21:43:24-815725 arm-9890 INFO ARM now monitors connections to service `resolver' at `[::]:23355' Feb 22 21:43:24-815767 arm-9890 INFO ARM now monitors connections to service `resolver' at `0.0.0.0:23355' Feb 22 21:43:24-815795 util-scheduler-21510 DEBUG destroying task 0x788af81211d0 Feb 22 21:43:24-815816 util-scheduler-21510 DEBUG select timeout = end of time Feb 22 21:43:24-815842 util-scheduler-21510 DEBUG Running task 0x788af8121080 Feb 22 21:43:24-815869 util-network-21510 DEBUG Accepting connection on `/tmp/gnunet-ng0-runtime//gnunet-service-arm.sock' Feb 22 21:43:24-815896 util-service-21510 DEBUG Service accepted incoming connection from . Feb 22 21:43:24-815952 util-network-21510 DEBUG Accepting connection on `/tmp/gnunet-ng0-runtime//gnunet-service-arm.sock' Feb 22 21:43:24-815973 util-scheduler-21510 DEBUG destroying task 0x788af8121080 Feb 22 21:43:24-815992 util-scheduler-21510 DEBUG select timeout = end of time Feb 22 21:43:24-816013 util-scheduler-21510 DEBUG Running task 0x788af81211d0 Feb 22 21:43:24-816059 util-mst-21510 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 22 21:43:24-816076 util-service-21510 DEBUG Received message of type 15 and size 4 from client Feb 22 21:43:24-816116 util-scheduler-21510 DEBUG Adding task 0x788af8121080 Feb 22 21:43:24-816136 util-mq-21510 DEBUG Received message of type 15 and size 4 Feb 22 21:43:24-816162 util-mq-21510 DEBUG sending message of type 15, queue empty (MQ: 0x788af81370c0) Feb 22 21:43:24-816179 util-service-21510 DEBUG Sending message of type 15 and size 4 to client Feb 22 21:43:24-816201 util-scheduler-21510 DEBUG canceling task 0x788af8121080 Feb 22 21:43:24-816216 util-scheduler-21510 DEBUG destroying task 0x788af8121080 Feb 22 21:43:24-816233 util-scheduler-21510 DEBUG Adding task 0x788af8121080 Feb 22 21:43:24-816249 util-mst-21510 DEBUG Server-mst leaves 0 bytes in private buffer Feb 22 21:43:24-816264 util-scheduler-21510 DEBUG destroying task 0x788af81211d0 Feb 22 21:43:24-816283 util-scheduler-21510 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-816305 util-scheduler-21510 DEBUG Running task 0x788af8121080 Feb 22 21:43:24-816321 util-mst-21510 DEBUG MST receives 0 bytes with 0 bytes already in private buffer Feb 22 21:43:24-816335 util-mst-21510 DEBUG Server-mst leaves 0 bytes in private buffer Feb 22 21:43:24-816352 util-scheduler-21510 DEBUG destroying task 0x788af8121080 Feb 22 21:43:24-816367 util-scheduler-21510 DEBUG Running task 0x788af8122d60 Feb 22 21:43:24-816381 util-service-21510 DEBUG service: sending message with type 15Feb 22 21:43:24-816411 util-scheduler-21510 DEBUG Adding task 0x788af8121080 Feb 22 21:43:24-816415 util-scheduler-12645 DEBUG Running task 0x7e716131e240 Feb 22 21:43:24-816428 util-scheduler-21510 DEBUG destroying task 0x788af8122d60 Feb 22 21:43:24-816437 util-resolver-api-12645 DEBUG Trying to resolve hostname `localhost'. Feb 22 21:43:24-816447 util-scheduler-21510 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-816453 util-scheduler-12645 DEBUG Adding task 0x7e716131e390 Feb 22 21:43:24-816465 util-scheduler-12645 DEBUG destroying task 0x7e716131e240 Feb 22 21:43:24-816468 util-scheduler-21510 DEBUG Running task 0x788af8121080 Feb 22 21:43:24-816476 util-scheduler-12645 DEBUG Running task 0x7e716131e1d0 Feb 22 21:43:24-816483 util-scheduler-21510 DEBUG destroying task 0x788af8121080 Feb 22 21:43:24-816497 util-mst-12645 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 22 21:43:24-816501 util-scheduler-21510 DEBUG select timeout = end of time Feb 22 21:43:24-816509 util-client-12645 DEBUG Received message of type 15 and size 4 from arm Feb 22 21:43:24-816523 util-mq-12645 DEBUG Received message of type 15 and size 4 Feb 22 21:43:24-816537 arm-api-12645 DEBUG Got confirmation from ARM that we are up! Feb 22 21:43:24-816550 util-mst-12645 DEBUG Server-mst leaves 0 bytes in private buffer Feb 22 21:43:24-816564 util-scheduler-12645 DEBUG destroying task 0x7e716131e1d0 Feb 22 21:43:24-816579 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-816797 util-scheduler-12645 DEBUG Running task 0x7e716131e390 Feb 22 21:43:24-816812 util-client-12645 DEBUG Trying to connect using address `::1:23355' Feb 22 21:43:24-816847 util-client-12645 DEBUG Trying to connect using address `127.0.0.1:23355' Feb 22 21:43:24-816901 util-resolver-api-12645 DEBUG Finished resolving hostname `localhost'. Feb 22 21:43:24-816912 util-scheduler-12645 DEBUG destroying task 0x7e716131e390 Feb 22 21:43:24-816923 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:29 2019 Feb 22 21:43:24-816922 util-scheduler-21510 DEBUG Running task 0x788af8122c10 Feb 22 21:43:24-816937 util-scheduler-12645 DEBUG Running task 0x7e716131e1d0 Feb 22 21:43:24-816948 util-client-12645 DEBUG Connection to `resolver' succeeded! Feb 22 21:43:24-816946 util-scheduler-21510 DEBUG canceling task 0x788af8122c80 Feb 22 21:43:24-816965 util-scheduler-12645 DEBUG canceling task 0x7e716131e470 Feb 22 21:43:24-816975 util-scheduler-12645 DEBUG destroying task 0x7e716131e470 Feb 22 21:43:24-816986 util-scheduler-12645 DEBUG destroying task 0x7e716131e1d0 Feb 22 21:43:24-816971 util-scheduler-21510 DEBUG destroying task 0x788af8122c80 Feb 22 21:43:24-816999 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:34 2019 Feb 22 21:43:24-817001 util-scheduler-21510 DEBUG canceling task 0x788af8122ba0 Feb 22 21:43:24-817030 util-scheduler-21510 DEBUG destroying task 0x788af8122ba0 Feb 22 21:43:24-817032 util-scheduler-12645 DEBUG Running task 0x7e716131e390 Feb 22 21:43:24-817048 util-client-12645 DEBUG message of type 4 trying to send with socket 0x7e71613476a0 (MQ: 0x7e7161338270 Feb 22 21:43:24-817056 arm-9890 DEBUG Starting service `resolver' using binary `gnunet-service-resolver' and configuration `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 22 21:43:24-817070 util-client-12645 DEBUG sending message of type 4 successful Feb 22 21:43:24-817087 util-scheduler-12645 DEBUG Adding task 0x7e716131e1d0 Feb 22 21:43:24-817100 util-scheduler-12645 DEBUG destroying task 0x7e716131e390 Feb 22 21:43:24-817112 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-817125 util-scheduler-12645 DEBUG Running task 0x7e716131e1d0 Feb 22 21:43:24-817133 util-scheduler-12645 DEBUG destroying task 0x7e716131e1d0 Feb 22 21:43:24-817145 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:34 2019 Feb 22 21:43:24-817311 arm-9890 INFO Starting service `resolver' Feb 22 21:43:24-817348 arm-9890 DEBUG Sending status 2 of service `resolver' to client Feb 22 21:43:24-817395 util-scheduler-21510 DEBUG destroying task 0x788af8122c10 Feb 22 21:43:24-817419 util-scheduler-21510 DEBUG select timeout = end of time Feb 22 21:43:24-822529 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 22 21:43:24-822794 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 22 21:43:24-822907 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 22 21:43:24-822977 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 22 21:43:24-823017 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 22 21:43:24-823081 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 22 21:43:24-823120 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 22 21:43:24-823185 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 22 21:43:24-823247 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 22 21:43:24-823324 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 22 21:43:24-823354 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 22 21:43:24-823419 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 22 21:43:24-823469 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 22 21:43:24-823532 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 22 21:43:24-823554 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 22 21:43:24-823618 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 22 21:43:24-823668 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 22 21:43:24-823732 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 22 21:43:24-823778 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 22 21:43:24-823842 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 22 21:43:24-823875 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 22 21:43:24-823939 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 22 21:43:24-824073 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 22 21:43:24-824140 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 22 21:43:24-824199 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 22 21:43:24-824265 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 22 21:43:24-824304 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 22 21:43:24-824369 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 22 21:43:24-824592 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 22 21:43:24-824662 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 22 21:43:24-824684 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 22 21:43:24-824751 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 22 21:43:24-824793 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 22 21:43:24-824859 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 22 21:43:24-825001 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 22 21:43:24-825068 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 22 21:43:24-825192 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 22 21:43:24-825257 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 22 21:43:24-825324 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 22 21:43:24-825391 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 22 21:43:24-825443 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 22 21:43:24-825511 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 22 21:43:24-825562 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 22 21:43:24-825642 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 22 21:43:24-825676 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 22 21:43:24-825741 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 22 21:43:24-825771 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 22 21:43:24-825836 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 22 21:43:24-825888 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 22 21:43:24-825953 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 22 21:43:24-825995 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 22 21:43:24-826059 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 22 21:43:24-826117 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 22 21:43:24-826177 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 22 21:43:24-826241 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 22 21:43:24-826893 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 22 21:43:24-826974 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 22 21:43:24-827039 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 22 21:43:24-827072 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 22 21:43:24-827133 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 22 21:43:24-827164 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 22 21:43:24-827223 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 22 21:43:24-827265 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 22 21:43:24-827322 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 22 21:43:24-827358 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 22 21:43:24-827415 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 22 21:43:24-827453 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 22 21:43:24-827510 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 22 21:43:24-827576 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 22 21:43:24-827635 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 22 21:43:24-827688 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 22 21:43:24-827748 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 22 21:43:24-827791 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 22 21:43:24-827852 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 22 21:43:24-827935 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 22 21:43:24-827999 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 22 21:43:24-828070 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 22 21:43:24-828129 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 22 21:43:24-828163 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 22 21:43:24-828244 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 22 21:43:24-828281 util-8273 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 22 21:43:24-828339 util-8273 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 22 21:43:24-828383 util-8273 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 22 21:43:24-828445 util-8273 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 22 21:43:24-828464 util-8273 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 22 21:43:24-828554 util-8273 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 22 21:43:24-828622 util-8273 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 22 21:43:24-828706 util-8273 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 22 21:43:24-828962 util-8273 DEBUG Failed to retrieve filename Feb 22 21:43:24-828981 util-service-8273 DEBUG Service `resolver' runs with configuration from `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 22 21:43:24-829054 util-scheduler-8273 DEBUG Registering signal handlers Feb 22 21:43:24-829131 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e080 Feb 22 21:43:24-829168 util-scheduler-8273 DEBUG Adding continuation task 0x79a0f8d1e160 Feb 22 21:43:24-829187 util-scheduler-8273 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-829216 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e080 Feb 22 21:43:24-829234 util-os-priority-8273 DEBUG Not installing a handler because $GNUNET_OS_CONTROL_PIPE is empty Feb 22 21:43:24-829260 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e080 Feb 22 21:43:24-829275 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e160 Feb 22 21:43:24-829292 util-scheduler-8273 DEBUG Adding shutdown task 0x79a0f8d1e080 Feb 22 21:43:24-829388 util-scheduler-8273 DEBUG Adding shutdown task 0x79a0f8d1e320 Feb 22 21:43:24-829461 resolver-8273 DEBUG Adding DNS server '192.168.1.1': success Feb 22 21:43:24-829478 resolver-8273 DEBUG Adding DNS server 'fda9:652b:4324::1': success Feb 22 21:43:24-829493 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e160 Feb 22 21:43:24-829511 util-scheduler-8273 DEBUG select timeout = end of time Feb 22 21:43:24-829534 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e240 Feb 22 21:43:24-829568 util-network-8273 DEBUG Accepting connection on `[::]:23355' Feb 22 21:43:24-829616 util-service-8273 DEBUG Service accepted incoming connection from [::1]:65212. Feb 22 21:43:24-829650 util-network-8273 DEBUG Accepting connection on `[::]:23355' Feb 22 21:43:24-829669 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e240 Feb 22 21:43:24-829685 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e2b0 Feb 22 21:43:24-829703 util-network-8273 DEBUG Accepting connection on `0.0.0.0:23355' Feb 22 21:43:24-829725 util-service-8273 DEBUG Service accepted incoming connection from 127.0.0.1:64898. Feb 22 21:43:24-829746 util-network-8273 DEBUG Accepting connection on `0.0.0.0:23355' Feb 22 21:43:24-829766 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e2b0 Feb 22 21:43:24-829784 util-scheduler-8273 DEBUG select timeout = end of time Feb 22 21:43:24-829804 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e160 Feb 22 21:43:24-829838 util-mst-8273 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 22 21:43:24-829858 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e160 Feb 22 21:43:24-829872 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e240 Feb 22 21:43:24-829892 resolver-8273 DEBUG Client dropped: 0x79a0f8d30100 (MQ: 0x79a0f8d37270) Feb 22 21:43:24-829909 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e160 Feb 22 21:43:24-829925 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e240 Feb 22 21:43:24-829945 util-scheduler-8273 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-829965 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e160 Feb 22 21:43:24-830016 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e160 Feb 22 21:43:24-830041 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e2b0 Feb 22 21:43:24-830061 util-mst-8273 DEBUG MST receives 0 bytes with 27 bytes already in private buffer Feb 22 21:43:24-830079 util-service-8273 DEBUG Received message of type 4 and size 27 from client Feb 22 21:43:24-830172 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e160 Feb 22 21:43:24-830195 util-mq-8273 DEBUG Received message of type 4 and size 27 Feb 22 21:43:24-830215 util-scheduler-8273 DEBUG canceling task 0x79a0f8d1e160 Feb 22 21:43:24-830228 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e160 Feb 22 21:43:24-830243 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e160 Feb 22 21:43:24-830265 resolver-8273 DEBUG No cache entry for 'uptimegirl' Feb 22 21:43:24-830279 resolver-8273 DEBUG resolve_and_cache `uptimegirl' Feb 22 21:43:24-830446 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e240 Feb 22 21:43:24-830471 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e470 Feb 22 21:43:24-830486 resolver-8273 DEBUG Resolving uptimegirl, client_request_id = 1, dns_id = 57877 Feb 22 21:43:24-830519 util-mst-8273 DEBUG Server-mst leaves 0 bytes in private buffer Feb 22 21:43:24-830535 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e2b0 Feb 22 21:43:24-830555 util-scheduler-8273 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-830573 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e470 Feb 22 21:43:24-830586 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e2b0 Feb 22 21:43:24-830649 resolver-8273 DEBUG Sent DNS request to [fda9:652b:4324::1]:53 Feb 22 21:43:24-830673 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e4e0 Feb 22 21:43:24-830690 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e470 Feb 22 21:43:24-830704 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e160 Feb 22 21:43:24-830719 util-mst-8273 DEBUG MST receives 0 bytes with 0 bytes already in private buffer Feb 22 21:43:24-830734 util-mst-8273 DEBUG Server-mst leaves 0 bytes in private buffer Feb 22 21:43:24-830745 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e160 Feb 22 21:43:24-830762 util-scheduler-8273 DEBUG select timeout = Fri Feb 22 21:43:25 2019 Feb 22 21:43:24-832093 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e4e0 Feb 22 21:43:24-832112 resolver-8273 DEBUG Receiving 72 byte DNS reply Feb 22 21:43:24-832160 resolver-8273 DEBUG Got reply for hostname uptimegirl and request ID 1 Feb 22 21:43:24-832193 util-scheduler-8273 DEBUG canceling task 0x79a0f8d1e2b0 Feb 22 21:43:24-832205 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e2b0 Feb 22 21:43:24-832222 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e160 Feb 22 21:43:24-832245 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e2b0 Feb 22 21:43:24-832260 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e4e0 Feb 22 21:43:24-832280 util-scheduler-8273 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-832300 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e160 Feb 22 21:43:24-832317 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e4e0 Feb 22 21:43:24-832359 resolver-8273 DEBUG Sent DNS request to [fda9:652b:4324::1]:53 Feb 22 21:43:24-832374 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e550 Feb 22 21:43:24-832386 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e160 Feb 22 21:43:24-832401 util-scheduler-8273 DEBUG select timeout = Fri Feb 22 21:43:25 2019 Feb 22 21:43:24-833974 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e550 Feb 22 21:43:24-833992 resolver-8273 DEBUG Receiving 84 byte DNS reply Feb 22 21:43:24-834014 resolver-8273 DEBUG Got reply for hostname uptimegirl and request ID 1 Feb 22 21:43:24-834036 resolver-8273 DEBUG No cache entry for 'uptimegirl' Feb 22 21:43:24-834047 resolver-8273 DEBUG Sending END message Feb 22 21:43:24-834067 util-mq-8273 DEBUG sending message of type 5, queue empty (MQ: 0x79a0f8d371e0) Feb 22 21:43:24-834083 util-service-8273 DEBUG Sending message of type 5 and size 8 to client Feb 22 21:43:24-834102 util-scheduler-8273 DEBUG canceling task 0x79a0f8d1e4e0 Feb 22 21:43:24-834116 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e4e0 Feb 22 21:43:24-834131 util-scheduler-8273 DEBUG canceling task 0x79a0f8d1e240 Feb 22 21:43:24-834144 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e240 Feb 22 21:43:24-834160 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e240 Feb 22 21:43:24-834173 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e550 Feb 22 21:43:24-834187 util-scheduler-8273 DEBUG select timeout = end of time Feb 22 21:43:24-834204 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e160 Feb 22 21:43:24-834217 util-service-8273 DEBUG service: sending message with type 5Feb 22 21:43:24-834247 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e4e0 Feb 22 21:43:24-834263 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e160 Feb 22 21:43:24-834272 util-scheduler-12645 DEBUG Running task 0x7e716131e320 Feb 22 21:43:24-834285 util-scheduler-8273 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-834304 util-mst-12645 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 22 21:43:24-834309 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e4e0 Feb 22 21:43:24-834329 util-scheduler-12645 DEBUG destroying task 0x7e716131e320 Feb 22 21:43:24-834418 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e4e0 Feb 22 21:43:24-834427 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:34 2019 Feb 22 21:43:24-834441 util-scheduler-8273 DEBUG select timeout = end of time Feb 22 21:43:24-834450 util-scheduler-12645 DEBUG Running task 0x7e716131e1d0 Feb 22 21:43:24-834473 util-mst-12645 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Feb 22 21:43:24-834492 util-client-12645 DEBUG Received message of type 5 and size 8 from resolver Feb 22 21:43:24-834507 util-mq-12645 DEBUG Received message of type 5 and size 8 Feb 22 21:43:24-834525 util-resolver-api-12645 DEBUG Received empty response from DNS service Feb 22 21:43:24-834540 test-gnunet-service-arm-12645 ERROR Failed to resolve our own hostname! Feb 22 21:43:24-834561 test-gnunet-service-arm-12645 ERROR Assertion failed at test_gnunet_service_arm.c:118. Feb 22 21:43:24-834576 arm-api-12645 DEBUG Stopping service `arm' Feb 22 21:43:24-834597 util-mq-12645 DEBUG sending message of type 9, queue empty (MQ: 0x7e7161338150) Feb 22 21:43:24-834613 util-resolver-api-12645 DEBUG Asked to cancel request to resolve hostname `uptimegirl'. Feb 22 21:43:24-834626 util-scheduler-12645 DEBUG canceling task 0x7e716131e2b0 Feb 22 21:43:24-834635 util-scheduler-12645 DEBUG destroying task 0x7e716131e2b0 Feb 22 21:43:24-834648 util-scheduler-12645 DEBUG Adding task 0x7e716131e160 Feb 22 21:43:24-834660 util-mst-12645 DEBUG Server-mst leaves 0 bytes in private buffer Feb 22 21:43:24-834673 util-scheduler-12645 DEBUG destroying task 0x7e716131e1d0 Feb 22 21:43:24-834689 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-834705 util-scheduler-12645 DEBUG Running task 0x7e716131e320 Feb 22 21:43:24-834714 util-client-12645 DEBUG message of type 9 trying to send with socket 0x7e7161347680 (MQ: 0x7e7161338150 Feb 22 21:43:24-834928 util-scheduler-21510 DEBUG Running task 0x788af81211d0 Feb 22 21:43:24-834953 util-mst-21510 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 22 21:43:24-834973 util-scheduler-21510 DEBUG destroying task 0x788af81211d0 Feb 22 21:43:24-834988 util-scheduler-21510 DEBUG select timeout = end of time Feb 22 21:43:24-835001 util-scheduler-21510 DEBUG Running task 0x788af8121080 Feb 22 21:43:24-835011 util-mst-21510 DEBUG MST receives 0 bytes with 20 bytes already in private buffer Feb 22 21:43:24-835021 util-service-21510 DEBUG Received message of type 9 and size 20 from client Feb 22 21:43:24-835032 util-scheduler-21510 DEBUG Adding task 0x788af81211d0 Feb 22 21:43:24-835041 util-mq-21510 DEBUG Received message of type 9 and size 20 Feb 22 21:43:24-835058 arm-9890 INFO Preparing to stop `arm' Feb 22 21:43:24-835067 util-scheduler-21510 DEBUG canceling task 0x788af81211d0 Feb 22 21:43:24-835076 util-scheduler-21510 DEBUG destroying task 0x788af81211d0 Feb 22 21:43:24-835086 util-scheduler-21510 DEBUG Adding task 0x788af81211d0 Feb 22 21:43:24-835094 arm-9890 DEBUG Sending status 3 of service `arm' to client Feb 22 21:43:24-835112 util-mq-21510 DEBUG sending message of type 10, queue empty (MQ: 0x788af81370c0) Feb 22 21:43:24-835122 util-service-21510 DEBUG Sending message of type 10 and size 24 to client Feb 22 21:43:24-835135 util-scheduler-21510 DEBUG Adding task 0x788af8122c10 Feb 22 21:43:24-835144 util-mst-21510 DEBUG Server-mst leaves 0 bytes in private buffer Feb 22 21:43:24-835153 util-scheduler-21510 DEBUG destroying task 0x788af8121080 Feb 22 21:43:24-835164 util-scheduler-21510 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-835178 util-scheduler-21510 DEBUG Running task 0x788af8122c10 Feb 22 21:43:24-835189 arm-9890 DEBUG Triggering shutdown Feb 22 21:43:24-835200 util-scheduler-21510 DEBUG GNUNET_SCHEDULER_shutdown Feb 22 21:43:24-835208 util-scheduler-21510 DEBUG canceling task 0x788af8121160 Feb 22 21:43:24-835217 util-scheduler-21510 DEBUG destroying task 0x788af8121160 Feb 22 21:43:24-835240 util-scheduler-21510 DEBUG destroying task 0x788af8122c10 Feb 22 21:43:24-835250 util-scheduler-21510 DEBUG Running task 0x788af81211d0 Feb 22 21:43:24-835259 util-mst-21510 DEBUG MST receives 0 bytes with 0 bytes already in private buffer Feb 22 21:43:24-835268 util-mst-21510 DEBUG Server-mst leaves 0 bytes in private buffer Feb 22 21:43:24-835277 util-scheduler-21510 DEBUG destroying task 0x788af81211d0 Feb 22 21:43:24-835286 util-scheduler-21510 DEBUG Running task 0x788af8122ba0 Feb 22 21:43:24-835295 util-service-21510 DEBUG service: sending message with type 10Feb 22 21:43:24-835307 util-scheduler-21510 DEBUG Adding task 0x788af8121160 Feb 22 21:43:24-835320 util-scheduler-21510 DEBUG destroying task 0x788af8122ba0 Feb 22 21:43:24-835334 util-scheduler-21510 DEBUG scheduler has more tasks ready! Feb 22 21:43:24-835350 util-scheduler-21510 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-835369 util-scheduler-21510 DEBUG Running task 0x788af8121240 Feb 22 21:43:24-835382 arm-9890 DEBUG First shutdown phase Feb 22 21:43:24-835447 util-client-12645 DEBUG sending message of type 9 successful Feb 22 21:43:24-835486 util-scheduler-21510 DEBUG canceling task 0x788af81229e0 Feb 22 21:43:24-835498 util-scheduler-21510 DEBUG destroying task 0x788af81229e0 Feb 22 21:43:24-835532 util-scheduler-12645 DEBUG Adding task 0x7e716131e1d0 Feb 22 21:43:24-835570 util-scheduler-21510 DEBUG canceling task 0x788af81225f0 Feb 22 21:43:24-835582 util-scheduler-21510 DEBUG destroying task 0x788af81225f0 Feb 22 21:43:24-835609 util-scheduler-12645 DEBUG destroying task 0x7e716131e320 Feb 22 21:43:24-835646 util-scheduler-21510 DEBUG canceling task 0x788af8122430 Feb 22 21:43:24-835657 util-scheduler-21510 DEBUG destroying task 0x788af8122430 Feb 22 21:43:24-835691 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-835731 util-scheduler-12645 DEBUG Running task 0x7e716131e160 Feb 22 21:43:24-835752 util-resolver-api-12645 DEBUG Disconnecting from DNS service Feb 22 21:43:24-835764 util-scheduler-12645 DEBUG canceling task 0x7e716131e2b0 Feb 22 21:43:24-835774 util-scheduler-12645 DEBUG destroying task 0x7e716131e2b0 Feb 22 21:43:24-835783 util-client-12645 DEBUG destroying socket: 0x7e71613476a0 Feb 22 21:43:24-835802 util-scheduler-12645 DEBUG destroying task 0x7e716131e160 Feb 22 21:43:24-835814 util-scheduler-12645 DEBUG Running task 0x7e716131e1d0 Feb 22 21:43:24-835834 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e470 Feb 22 21:43:24-835846 arm-9890 INFO Stopping service `resolver' Feb 22 21:43:24-835855 resolver-8273 DEBUG Client dropped: 0x79a0f8d30080 (MQ: 0x79a0f8d371e0) Feb 22 21:43:24-835869 util-os-priority-21510 DEBUG Sending signal 15 to pid: 8273 via system call Feb 22 21:43:24-835874 util-scheduler-8273 DEBUG Adding task 0x79a0f8d1e160 Feb 22 21:43:24-835901 arm-9890 DEBUG resolver Feb 22 21:43:24-835890 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e470 Feb 22 21:43:24-835916 arm-9890 DEBUG Delaying shutdown, have 1 childs still running Feb 22 21:43:24-835925 util-scheduler-8273 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-835931 util-scheduler-21510 DEBUG destroying task 0x788af8121240 Feb 22 21:43:24-835946 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e160 Feb 22 21:43:24-835948 util-scheduler-21510 DEBUG scheduler has more tasks ready! Feb 22 21:43:24-835968 util-scheduler-21510 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-835972 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e160 Feb 22 21:43:24-835987 util-scheduler-21510 DEBUG Running task 0x788af8121160 Feb 22 21:43:24-835989 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e0f0 Feb 22 21:43:24-836001 util-scheduler-21510 DEBUG destroying task 0x788af8121160 Feb 22 21:43:24-836009 util-scheduler-8273 DEBUG GNUNET_SCHEDULER_shutdown Feb 22 21:43:24-836020 util-scheduler-21510 DEBUG select timeout = end of time Feb 22 21:43:24-836027 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e0f0 Feb 22 21:43:24-836045 util-scheduler-8273 DEBUG scheduler has more tasks ready! Feb 22 21:43:24-836044 util-scheduler-12645 DEBUG destroying task 0x7e716131e1d0 Feb 22 21:43:24-836080 util-scheduler-8273 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-836080 util-scheduler-12645 DEBUG Running task 0x7e716131e240 Feb 22 21:43:24-836101 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e080 Feb 22 21:43:24-836101 util-mst-12645 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 22 21:43:24-836117 util-scheduler-8273 DEBUG canceling task 0x79a0f8d1e1d0 Feb 22 21:43:24-836122 util-scheduler-12645 DEBUG destroying task 0x7e716131e240 Feb 22 21:43:24-836133 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e1d0 Feb 22 21:43:24-836143 util-scheduler-12645 DEBUG select timeout = end of time Feb 22 21:43:24-836161 util-scheduler-12645 DEBUG Running task 0x7e716131e160 Feb 22 21:43:24-836178 util-mst-12645 DEBUG MST receives 0 bytes with 24 bytes already in private buffer Feb 22 21:43:24-836194 util-client-12645 DEBUG Received message of type 10 and size 24 from arm Feb 22 21:43:24-836209 util-mq-12645 DEBUG Received message of type 10 and size 24 Feb 22 21:43:24-836225 util-mst-12645 DEBUG Server-mst leaves 0 bytes in private buffer Feb 22 21:43:24-836148 util-scheduler-8273 DEBUG canceling task 0x79a0f8d1e390 Feb 22 21:43:24-836240 util-scheduler-12645 DEBUG destroying task 0x7e716131e160 Feb 22 21:43:24-836256 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e390 Feb 22 21:43:24-836261 util-scheduler-12645 DEBUG select timeout = end of time Feb 22 21:43:24-836273 util-scheduler-8273 DEBUG canceling task 0x79a0f8d1e400 Feb 22 21:43:24-836286 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e400 Feb 22 21:43:24-836296 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e080 Feb 22 21:43:24-836305 util-scheduler-8273 DEBUG Running task 0x79a0f8d1e320 Feb 22 21:43:24-836321 util-scheduler-8273 DEBUG canceling task 0x79a0f8d1e240 Feb 22 21:43:24-836330 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e240 Feb 22 21:43:24-836342 util-scheduler-8273 DEBUG canceling task 0x79a0f8d1e2b0 Feb 22 21:43:24-836351 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e2b0 Feb 22 21:43:24-836361 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e320 Feb 22 21:43:24-836370 util-scheduler-8273 DEBUG GNUNET_SCHEDULER_shutdown Feb 22 21:43:24-836378 util-scheduler-8273 DEBUG canceling task 0x79a0f8d1e160 Feb 22 21:43:24-836387 util-scheduler-8273 DEBUG destroying task 0x79a0f8d1e160 Feb 22 21:43:24-836844 util-scheduler-21510 DEBUG select timeout = end of time Feb 22 21:43:24-836862 util-scheduler-21510 DEBUG Running task 0x788af81212b0 Feb 22 21:43:24-836893 arm-9890 INFO Service `resolver' took 1024 µs to terminate Feb 22 21:43:24-836904 arm-9890 DEBUG Sending status 1 of service `resolver' to client Feb 22 21:43:24-836915 arm-9890 DEBUG Last shutdown phase Feb 22 21:43:24-836927 util-scheduler-21510 DEBUG canceling task 0x788af8122cf0 Feb 22 21:43:24-836936 util-scheduler-21510 DEBUG destroying task 0x788af8122cf0 Feb 22 21:43:24-836947 arm-9890 DEBUG Client dropped: 0x788af8133080 (MQ: 0x788af81370c0) Feb 22 21:43:24-836956 util-scheduler-21510 DEBUG canceling task 0x788af8121080 Feb 22 21:43:24-836965 util-scheduler-21510 DEBUG destroying task 0x788af8121080 Feb 22 21:43:24-836976 util-scheduler-21510 DEBUG Adding task 0x788af8121080 Feb 22 21:43:24-836984 util-scheduler-21510 DEBUG canceling task 0x788af8121160 Feb 22 21:43:24-836993 util-scheduler-21510 DEBUG destroying task 0x788af8121160 Feb 22 21:43:24-837006 util-scheduler-21510 DEBUG destroying task 0x788af81212b0 Feb 22 21:43:24-837023 util-scheduler-21510 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-837040 util-scheduler-21510 DEBUG Running task 0x788af8121080 Feb 22 21:43:24-837065 util-scheduler-21510 DEBUG destroying task 0x788af8121080 Feb 22 21:43:24-837078 util-scheduler-21510 DEBUG GNUNET_SCHEDULER_shutdown Feb 22 21:43:24-837112 util-21510 DEBUG Failed to retrieve filename Feb 22 21:43:24-838126 util-scheduler-12645 DEBUG Running task 0x7e716131e1d0 Feb 22 21:43:24-838162 util-scheduler-12645 DEBUG Adding task 0x7e716131e160 Feb 22 21:43:24-838209 util-scheduler-12645 DEBUG Adding task 0x7e716131e240 Feb 22 21:43:24-838237 util-client-12645 DEBUG destroying socket: 0x7e7161347680 Feb 22 21:43:24-838269 util-scheduler-12645 DEBUG destroying task 0x7e716131e1d0 Feb 22 21:43:24-838290 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-838311 util-scheduler-12645 DEBUG Running task 0x7e716131e240 Feb 22 21:43:24-838335 util-12645 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Feb 22 21:43:24-838351 util-12645 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Feb 22 21:43:24-838373 util-12645 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Feb 22 21:43:24-838392 util-12645 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Feb 22 21:43:24-838412 util-12645 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 22 21:43:24-838429 util-12645 DEBUG Split into `TMP' and `' with default /tmp Feb 22 21:43:24-838451 util-12645 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Feb 22 21:43:24-838470 util-12645 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Feb 22 21:43:24-838486 util-12645 DEBUG Asked to $-expand ${USER:-user} Feb 22 21:43:24-838502 util-12645 DEBUG Split into `USER' and `' with default user Feb 22 21:43:24-838532 util-scheduler-12645 DEBUG Adding task 0x7e716131e1d0 Feb 22 21:43:24-838554 arm-api-12645 DEBUG Sending TEST message to ARM Feb 22 21:43:24-838572 util-mq-12645 DEBUG sending message of type 15, queue empty (MQ: 0x7e7161338150) Feb 22 21:43:24-838588 util-client-12645 DEBUG message of type 15 waiting for socket Feb 22 21:43:24-838604 util-scheduler-12645 DEBUG destroying task 0x7e716131e240 Feb 22 21:43:24-838620 util-scheduler-12645 DEBUG Running task 0x7e716131e160 Feb 22 21:43:24-838641 arm-api-12645 DEBUG Disconnecting from ARM service Feb 22 21:43:24-838657 util-scheduler-12645 DEBUG canceling task 0x7e716131e1d0 Feb 22 21:43:24-838676 util-scheduler-12645 DEBUG destroying task 0x7e716131e1d0 Feb 22 21:43:24-838696 util-mq-12645 DEBUG MQ destroy drops current message of type 15 Feb 22 21:43:24-838716 util-scheduler-12645 DEBUG destroying task 0x7e716131e160 Feb 22 21:43:24-838736 util-scheduler-12645 DEBUG GNUNET_SCHEDULER_shutdown Feb 22 21:43:24-838754 util-scheduler-12645 DEBUG canceling task 0x7e716131e0f0 Feb 22 21:43:24-838769 util-scheduler-12645 DEBUG destroying task 0x7e716131e0f0 Feb 22 21:43:24-838788 util-scheduler-12645 DEBUG scheduler has more tasks ready! Feb 22 21:43:24-838808 util-scheduler-12645 DEBUG select timeout = Fri Feb 22 21:43:24 2019 Feb 22 21:43:24-838830 util-scheduler-12645 DEBUG Running task 0x7e716131e080 Feb 22 21:43:24-838849 util-scheduler-12645 DEBUG destroying task 0x7e716131e080 Feb 22 21:43:24-838866 util-scheduler-12645 DEBUG GNUNET_SCHEDULER_shutdown Test failed with error code 3 FAIL test_gnunet_service_arm (exit status: 3)