================================================ 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 23 23:45:33-583682 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 23 23:45:33-583816 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 23 23:45:33-583867 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 23 23:45:33-583900 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 23 23:45:33-583917 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 23 23:45:33-583947 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 23 23:45:33-583964 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 23 23:45:33-583995 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 23 23:45:33-584023 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 23 23:45:33-584053 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 23 23:45:33-584066 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 23 23:45:33-584097 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 23 23:45:33-584118 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 23 23:45:33-584148 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 23 23:45:33-584157 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 23 23:45:33-584188 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 23 23:45:33-584212 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 23 23:45:33-584242 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 23 23:45:33-584262 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 23 23:45:33-584293 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 23 23:45:33-584308 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 23 23:45:33-584339 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 23 23:45:33-584387 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 23 23:45:33-584417 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 23 23:45:33-584443 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 23 23:45:33-584473 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 23 23:45:33-584490 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 23 23:45:33-584524 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 23 23:45:33-584621 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 23 23:45:33-584653 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 23 23:45:33-584663 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 23 23:45:33-584694 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 23 23:45:33-584712 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 23 23:45:33-584743 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 23 23:45:33-584830 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 23 23:45:33-584862 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 23 23:45:33-584917 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 23 23:45:33-584947 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 23 23:45:33-584976 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 23 23:45:33-585007 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 23 23:45:33-585031 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 23 23:45:33-585061 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 23 23:45:33-585084 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 23 23:45:33-585114 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 23 23:45:33-585128 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 23 23:45:33-585158 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 23 23:45:33-585172 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 23 23:45:33-585202 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 23 23:45:33-585227 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 23 23:45:33-585257 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 23 23:45:33-585275 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 23 23:45:33-585306 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 23 23:45:33-585330 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 23 23:45:33-585360 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 23 23:45:33-585394 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 23 23:45:33-585424 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 23 23:45:33-585454 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 23 23:45:33-585484 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 23 23:45:33-585499 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 23 23:45:33-585530 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 23 23:45:33-585545 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 23 23:45:33-585576 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 23 23:45:33-585597 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 23 23:45:33-585627 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 23 23:45:33-585645 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 23 23:45:33-585676 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 23 23:45:33-585695 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 23 23:45:33-585726 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 23 23:45:33-585757 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 23 23:45:33-585799 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 23 23:45:33-585827 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 23 23:45:33-585857 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 23 23:45:33-585879 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 23 23:45:33-585910 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 23 23:45:33-585951 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 23 23:45:33-585982 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 23 23:45:33-586019 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 23 23:45:33-586049 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 23 23:45:33-586066 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 23 23:45:33-586099 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 23 23:45:33-586118 util-12332 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 23 23:45:33-586148 util-12332 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 23 23:45:33-586169 util-12332 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 23 23:45:33-586201 util-12332 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 23 23:45:33-586210 util-12332 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 23 23:45:33-586256 util-12332 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 23 23:45:33-586291 util-12332 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 23 23:45:33-586334 util-12332 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 23 23:45:33-586435 util-scheduler-12332 DEBUG Registering signal handlers Feb 23 23:45:33-586466 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e080 Feb 23 23:45:33-586482 util-scheduler-12332 DEBUG Adding continuation task 0x6fe30d31e160 Feb 23 23:45:33-586493 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-586508 util-scheduler-12332 DEBUG Running task 0x6fe30d31e080 Feb 23 23:45:33-586517 util-os-priority-12332 DEBUG Not installing a handler because $GNUNET_OS_CONTROL_PIPE is empty Feb 23 23:45:33-586528 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e080 Feb 23 23:45:33-586535 util-scheduler-12332 DEBUG Running task 0x6fe30d31e160 Feb 23 23:45:33-586552 util-speedup-12332 DEBUG Speed up disabled Feb 23 23:45:33-586561 util-scheduler-12332 DEBUG Adding shutdown task 0x6fe30d31e080 Feb 23 23:45:33-586579 util-12332 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Feb 23 23:45:33-586587 util-12332 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Feb 23 23:45:33-586596 util-12332 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Feb 23 23:45:33-586604 util-12332 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-586612 util-12332 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-586619 util-12332 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-586632 util-12332 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Feb 23 23:45:33-586648 util-12332 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Feb 23 23:45:33-586657 util-12332 DEBUG Asked to $-expand ${USER:-user} Feb 23 23:45:33-586664 util-12332 DEBUG Split into `USER' and `' with default user Feb 23 23:45:33-586676 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e1d0 Feb 23 23:45:33-586694 arm-api-12332 DEBUG Sending TEST message to ARM Feb 23 23:45:33-586704 util-mq-12332 DEBUG sending message of type 15, queue empty (MQ: 0x6fe30d338150) Feb 23 23:45:33-586712 util-client-12332 DEBUG message of type 15 waiting for socket Feb 23 23:45:33-586723 arm-api-12332 DEBUG Starting service `arm' Feb 23 23:45:33-586733 arm-api-12332 DEBUG Starting ARM service Feb 23 23:45:33-586868 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e240 Feb 23 23:45:33-586891 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e160 Feb 23 23:45:33-586901 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-586913 util-scheduler-12332 DEBUG Running task 0x6fe30d31e240 Feb 23 23:45:33-586921 arm-api-12332 DEBUG Notifying client that we started the ARM service Feb 23 23:45:33-586930 test-gnunet-service-arm-12332 DEBUG Trying to resolve our own hostname! Feb 23 23:45:33-586945 util-resolver-api-12332 DEBUG Resolving our hostname `uptimegirl' Feb 23 23:45:33-586954 util-resolver-api-12332 DEBUG Trying to resolve hostname `uptimegirl'. Feb 23 23:45:33-586966 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e2b0 Feb 23 23:45:33-586978 util-resolver-api-12332 DEBUG Will try to connect to DNS service in 1 ms Feb 23 23:45:33-586985 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e320 Feb 23 23:45:33-586996 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e240 Feb 23 23:45:33-587003 util-scheduler-12332 DEBUG Running task 0x6fe30d31e1d0 Feb 23 23:45:33-587014 util-12332 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Feb 23 23:45:33-587022 util-12332 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Feb 23 23:45:33-587030 util-12332 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Feb 23 23:45:33-587038 util-12332 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-587047 util-12332 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-587054 util-12332 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-587064 util-12332 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Feb 23 23:45:33-587071 util-12332 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Feb 23 23:45:33-587079 util-12332 DEBUG Asked to $-expand ${USER:-user} Feb 23 23:45:33-587087 util-12332 DEBUG Split into `USER' and `' with default user Feb 23 23:45:33-587121 util-client-12332 DEBUG Failed to establish connection to `arm', no further addresses to try, will try again in 2 ms. Feb 23 23:45:33-587130 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e240 Feb 23 23:45:33-587137 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e1d0 Feb 23 23:45:33-587146 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-589606 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 23 23:45:33-589732 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 23 23:45:33-589786 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 23 23:45:33-589818 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 23 23:45:33-589835 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 23 23:45:33-589866 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 23 23:45:33-589882 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 23 23:45:33-589912 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 23 23:45:33-589953 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 23 23:45:33-589985 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 23 23:45:33-589999 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 23 23:45:33-590029 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 23 23:45:33-590050 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 23 23:45:33-590080 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 23 23:45:33-590090 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 23 23:45:33-590119 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 23 23:45:33-590143 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 23 23:45:33-590173 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 23 23:45:33-590194 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 23 23:45:33-590224 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 23 23:45:33-590239 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 23 23:45:33-590270 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 23 23:45:33-590318 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 23 23:45:33-590348 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 23 23:45:33-590374 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 23 23:45:33-590404 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 23 23:45:33-590421 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 23 23:45:33-590452 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 23 23:45:33-590550 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 23 23:45:33-590581 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 23 23:45:33-590593 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 23 23:45:33-590623 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 23 23:45:33-590641 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 23 23:45:33-590672 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 23 23:45:33-590741 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 23 23:45:33-590772 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 23 23:45:33-590827 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 23 23:45:33-590857 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 23 23:45:33-590886 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 23 23:45:33-590916 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 23 23:45:33-590940 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 23 23:45:33-590971 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 23 23:45:33-591001 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 23 23:45:33-591033 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 23 23:45:33-591047 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 23 23:45:33-591077 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 23 23:45:33-591091 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 23 23:45:33-591121 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 23 23:45:33-591146 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 23 23:45:33-591176 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 23 23:45:33-591194 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 23 23:45:33-591224 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 23 23:45:33-591248 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 23 23:45:33-591278 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 23 23:45:33-591311 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 23 23:45:33-591342 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 23 23:45:33-591372 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 23 23:45:33-591404 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 23 23:45:33-591419 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 23 23:45:33-591449 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 23 23:45:33-591464 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 23 23:45:33-591494 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 23 23:45:33-591515 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 23 23:45:33-591545 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 23 23:45:33-591563 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 23 23:45:33-591593 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 23 23:45:33-591613 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 23 23:45:33-591643 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 23 23:45:33-591678 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 23 23:45:33-591708 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 23 23:45:33-591736 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 23 23:45:33-591766 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 23 23:45:33-591788 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 23 23:45:33-591819 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 23 23:45:33-591862 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 23 23:45:33-591893 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 23 23:45:33-591940 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 23 23:45:33-591972 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 23 23:45:33-591989 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 23 23:45:33-592023 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 23 23:45:33-592041 util-5556 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 23 23:45:33-592071 util-5556 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 23 23:45:33-592092 util-5556 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 23 23:45:33-592125 util-5556 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 23 23:45:33-592134 util-5556 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 23 23:45:33-592181 util-5556 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 23 23:45:33-592216 util-5556 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 23 23:45:33-592259 util-5556 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 23 23:45:33-592363 util-5556 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Feb 23 23:45:33-592375 util-5556 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Feb 23 23:45:33-592384 util-5556 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Feb 23 23:45:33-592393 util-5556 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-592401 util-5556 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-592409 util-5556 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-592430 util-5556 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Feb 23 23:45:33-592438 util-5556 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Feb 23 23:45:33-592447 util-5556 DEBUG Asked to $-expand ${USER:-user} Feb 23 23:45:33-592455 util-5556 DEBUG Split into `USER' and `' with default user Feb 23 23:45:33-593208 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593288 util-service-3003 DEBUG Service `arm' runs with configuration from `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 23 23:45:33-593350 util-scheduler-3003 DEBUG Registering signal handlers Feb 23 23:45:33-593383 util-scheduler-3003 DEBUG Adding task 0x71ce06321080 Feb 23 23:45:33-593407 util-scheduler-3003 DEBUG Adding continuation task 0x71ce063211d0 Feb 23 23:45:33-593418 util-scheduler-3003 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-593451 util-scheduler-3003 DEBUG Running task 0x71ce06321080 Feb 23 23:45:33-593461 util-os-priority-3003 DEBUG Not installing a handler because $GNUNET_OS_CONTROL_PIPE is empty Feb 23 23:45:33-593502 util-scheduler-3003 DEBUG destroying task 0x71ce06321080 Feb 23 23:45:33-593511 util-scheduler-3003 DEBUG Running task 0x71ce063211d0 Feb 23 23:45:33-593776 util-scheduler-3003 DEBUG Adding shutdown task 0x71ce06321240 Feb 23 23:45:33-593790 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593811 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593837 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593854 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593870 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593886 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593902 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593918 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593945 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593961 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593977 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-593993 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594010 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594026 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594043 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594059 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594075 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594092 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594108 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594125 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594145 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594162 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594180 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594198 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594215 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594232 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594249 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594266 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594282 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594300 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594317 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594337 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594353 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594371 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594388 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594406 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594429 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594448 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-594487 util-3003 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-nat-auto.sock Feb 23 23:45:33-594496 util-3003 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-nat-auto.sock' with default (null) Feb 23 23:45:33-594505 util-3003 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 23 23:45:33-594513 util-3003 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-594522 util-3003 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-594530 util-3003 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-594965 arm-5556 INFO ARM now monitors connections to service `nat-auto' at `/tmp/gnunet-system-runtime//gnunet-service-nat-auto.sock' Feb 23 23:45:33-594981 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-595011 util-3003 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-nat.sock Feb 23 23:45:33-595020 util-3003 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-nat.sock' with default (null) Feb 23 23:45:33-595028 util-3003 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 23 23:45:33-595037 util-3003 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-595045 util-3003 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-595053 util-3003 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-595214 arm-5556 INFO ARM now monitors connections to service `nat' at `/tmp/gnunet-system-runtime//gnunet-service-nat.sock' Feb 23 23:45:33-595228 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-595249 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-595267 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-595288 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-595308 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-595327 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-595354 util-3003 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-statistics.sock Feb 23 23:45:33-595391 util-3003 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-statistics.sock' with default (null) Feb 23 23:45:33-595400 util-3003 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 23 23:45:33-595407 util-3003 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-595415 util-3003 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-595423 util-3003 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-595586 arm-5556 INFO ARM now monitors connections to service `statistics' at `/tmp/gnunet-system-runtime//gnunet-service-statistics.sock' Feb 23 23:45:33-595599 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-595653 util-3003 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-resolver.sock Feb 23 23:45:33-595661 util-3003 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-resolver.sock' with default (null) Feb 23 23:45:33-595669 util-3003 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 23 23:45:33-595677 util-3003 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-595685 util-3003 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-595692 util-3003 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-595853 arm-5556 INFO ARM now monitors connections to service `resolver' at `/tmp/gnunet-system-runtime//gnunet-service-resolver.sock' Feb 23 23:45:33-595887 arm-5556 INFO ARM now monitors connections to service `resolver' at `[::]:23355' Feb 23 23:45:33-595907 arm-5556 INFO ARM now monitors connections to service `resolver' at `0.0.0.0:23355' Feb 23 23:45:33-595920 util-scheduler-3003 DEBUG destroying task 0x71ce063211d0 Feb 23 23:45:33-595929 util-scheduler-3003 DEBUG select timeout = end of time Feb 23 23:45:33-600613 util-scheduler-12332 DEBUG Running task 0x6fe30d31e240 Feb 23 23:45:33-600630 util-12332 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Feb 23 23:45:33-600638 util-12332 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Feb 23 23:45:33-600647 util-12332 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Feb 23 23:45:33-600655 util-12332 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-600663 util-12332 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-600670 util-12332 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-600680 util-12332 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Feb 23 23:45:33-600687 util-12332 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Feb 23 23:45:33-600695 util-12332 DEBUG Asked to $-expand ${USER:-user} Feb 23 23:45:33-600703 util-12332 DEBUG Split into `USER' and `' with default user Feb 23 23:45:33-600735 util-scheduler-3003 DEBUG Running task 0x71ce06321080 Feb 23 23:45:33-600751 util-network-3003 DEBUG Accepting connection on `/tmp/gnunet-ng0-runtime//gnunet-service-arm.sock' Feb 23 23:45:33-600764 util-service-3003 DEBUG Service accepted incoming connection from @. Feb 23 23:45:33-600791 util-network-3003 DEBUG Accepting connection on `/tmp/gnunet-ng0-runtime//gnunet-service-arm.sock' Feb 23 23:45:33-600801 util-scheduler-3003 DEBUG destroying task 0x71ce06321080 Feb 23 23:45:33-600811 util-scheduler-3003 DEBUG select timeout = end of time Feb 23 23:45:33-600826 util-client-12332 DEBUG Successfully connected to unixpath `/tmp/gnunet-ng0-runtime//gnunet-service-arm.sock'! Feb 23 23:45:33-600841 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e240 Feb 23 23:45:33-600850 util-scheduler-12332 DEBUG Running task 0x6fe30d31e320 Feb 23 23:45:33-600858 util-resolver-api-12332 DEBUG Trying to connect to DNS service Feb 23 23:45:33-600868 util-12332 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-resolver.sock Feb 23 23:45:33-600875 util-12332 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-resolver.sock' with default (null) Feb 23 23:45:33-600893 util-12332 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 23 23:45:33-600901 util-12332 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-600910 util-12332 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-600917 util-12332 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-600946 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e240 Feb 23 23:45:33-600959 util-resolver-api-12332 DEBUG Transmitting DNS resolution request (ID 1) to DNS service Feb 23 23:45:33-600967 util-mq-12332 DEBUG sending message of type 4, queue empty (MQ: 0x6fe30d338270) Feb 23 23:45:33-600974 util-client-12332 DEBUG message of type 4 waiting for socket Feb 23 23:45:33-600981 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e320 Feb 23 23:45:33-600991 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-601002 util-scheduler-12332 DEBUG Running task 0x6fe30d31e240 Feb 23 23:45:33-601011 util-12332 DEBUG Asked to $-expand $GNUNET_RUNTIME_DIR/gnunet-service-resolver.sock Feb 23 23:45:33-601018 util-12332 DEBUG Split into `GNUNET_RUNTIME_DIR' and `gnunet-service-resolver.sock' with default (null) Feb 23 23:45:33-601026 util-12332 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-system-runtime/ Feb 23 23:45:33-601033 util-12332 DEBUG Split into `TMPDIR' and `/gnunet-system-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-601041 util-12332 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-601049 util-12332 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-601078 util-scheduler-3003 DEBUG Running task 0x71ce06322ba0 Feb 23 23:45:33-601092 util-scheduler-3003 DEBUG canceling task 0x71ce06322c80 Feb 23 23:45:33-601101 util-scheduler-3003 DEBUG destroying task 0x71ce06322c80 Feb 23 23:45:33-601109 util-scheduler-3003 DEBUG canceling task 0x71ce06322c10 Feb 23 23:45:33-601117 util-scheduler-3003 DEBUG destroying task 0x71ce06322c10 Feb 23 23:45:33-601131 arm-5556 DEBUG Starting service `resolver' using binary `gnunet-service-resolver' and configuration `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 23 23:45:33-601259 arm-5556 INFO Starting service `resolver' Feb 23 23:45:33-601276 arm-5556 DEBUG Sending status 2 of service `resolver' to client Feb 23 23:45:33-601302 util-scheduler-3003 DEBUG destroying task 0x71ce06322ba0 Feb 23 23:45:33-601314 util-scheduler-3003 DEBUG select timeout = end of time Feb 23 23:45:33-601329 util-client-12332 DEBUG Successfully connected to unixpath `/tmp/gnunet-system-runtime//gnunet-service-resolver.sock'! Feb 23 23:45:33-601341 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e240 Feb 23 23:45:33-601350 util-scheduler-12332 DEBUG Running task 0x6fe30d31e390 Feb 23 23:45:33-601358 util-client-12332 DEBUG message of type 15 trying to send with socket 0x6fe30d347680 (MQ: 0x6fe30d338150 Feb 23 23:45:33-601378 util-scheduler-3003 DEBUG Running task 0x71ce063211d0 Feb 23 23:45:33-601412 util-mst-3003 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 23 23:45:33-601422 util-service-3003 DEBUG Received message of type 15 and size 4 from client Feb 23 23:45:33-601432 util-scheduler-3003 DEBUG Adding task 0x71ce06321080 Feb 23 23:45:33-601441 util-mq-3003 DEBUG Received message of type 15 and size 4 Feb 23 23:45:33-601455 util-mq-3003 DEBUG sending message of type 15, queue empty (MQ: 0x71ce063370c0) Feb 23 23:45:33-601463 util-service-3003 DEBUG Sending message of type 15 and size 4 to client Feb 23 23:45:33-601473 util-scheduler-3003 DEBUG canceling task 0x71ce06321080 Feb 23 23:45:33-601481 util-scheduler-3003 DEBUG destroying task 0x71ce06321080 Feb 23 23:45:33-601489 util-scheduler-3003 DEBUG Adding task 0x71ce06321080 Feb 23 23:45:33-601497 util-mst-3003 DEBUG Server-mst leaves 0 bytes in private buffer Feb 23 23:45:33-601504 util-scheduler-3003 DEBUG destroying task 0x71ce063211d0 Feb 23 23:45:33-601514 util-scheduler-3003 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-601524 util-scheduler-3003 DEBUG Running task 0x71ce06321080 Feb 23 23:45:33-601542 util-mst-3003 DEBUG MST receives 0 bytes with 0 bytes already in private buffer Feb 23 23:45:33-601550 util-mst-3003 DEBUG Server-mst leaves 0 bytes in private buffer Feb 23 23:45:33-601558 util-scheduler-3003 DEBUG destroying task 0x71ce06321080 Feb 23 23:45:33-601565 util-scheduler-3003 DEBUG Running task 0x71ce06322ba0 Feb 23 23:45:33-601573 util-service-3003 DEBUG service: sending message with type 15Feb 23 23:45:33-601589 util-scheduler-3003 DEBUG Adding task 0x71ce06321080 Feb 23 23:45:33-601597 util-scheduler-3003 DEBUG destroying task 0x71ce06322ba0 Feb 23 23:45:33-601606 util-scheduler-3003 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-601616 util-scheduler-3003 DEBUG Running task 0x71ce06321080 Feb 23 23:45:33-601623 util-scheduler-3003 DEBUG destroying task 0x71ce06321080 Feb 23 23:45:33-601632 util-scheduler-3003 DEBUG select timeout = end of time Feb 23 23:45:33-601647 util-client-12332 DEBUG sending message of type 15 successful Feb 23 23:45:33-601660 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e240 Feb 23 23:45:33-601669 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e390 Feb 23 23:45:33-601679 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-601690 util-scheduler-12332 DEBUG Running task 0x6fe30d31e240 Feb 23 23:45:33-601697 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e240 Feb 23 23:45:33-601704 util-scheduler-12332 DEBUG Running task 0x6fe30d31e1d0 Feb 23 23:45:33-601717 util-mst-12332 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 23 23:45:33-601725 util-client-12332 DEBUG Received message of type 15 and size 4 from arm Feb 23 23:45:33-601734 util-mq-12332 DEBUG Received message of type 15 and size 4 Feb 23 23:45:33-601742 arm-api-12332 DEBUG Got confirmation from ARM that we are up! Feb 23 23:45:33-601750 util-mst-12332 DEBUG Server-mst leaves 0 bytes in private buffer Feb 23 23:45:33-601758 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e1d0 Feb 23 23:45:33-601765 util-scheduler-12332 DEBUG Running task 0x6fe30d31e470 Feb 23 23:45:33-601773 util-client-12332 DEBUG message of type 4 trying to send with socket 0x6fe30d3476a0 (MQ: 0x6fe30d338270 Feb 23 23:45:33-601781 util-client-12332 DEBUG sending message of type 4 successful Feb 23 23:45:33-601789 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e1d0 Feb 23 23:45:33-601797 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e470 Feb 23 23:45:33-601806 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-601816 util-scheduler-12332 DEBUG Running task 0x6fe30d31e1d0 Feb 23 23:45:33-601823 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e1d0 Feb 23 23:45:33-601832 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:43 2019 Feb 23 23:45:33-603769 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 23 23:45:33-603901 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/util.conf' Feb 23 23:45:33-603957 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 23 23:45:33-603991 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/resolver.conf' Feb 23 23:45:33-604009 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 23 23:45:33-604042 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/statistics.conf' Feb 23 23:45:33-604060 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 23 23:45:33-604092 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/arm.conf' Feb 23 23:45:33-604122 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 23 23:45:33-604153 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testing.conf' Feb 23 23:45:33-604167 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 23 23:45:33-604210 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerinfo.conf' Feb 23 23:45:33-604233 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 23 23:45:33-604265 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datacache.conf' Feb 23 23:45:33-604276 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 23 23:45:33-604307 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/datastore.conf' Feb 23 23:45:33-604332 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 23 23:45:33-604363 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/template.conf' Feb 23 23:45:33-604386 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 23 23:45:33-604418 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/peerstore.conf' Feb 23 23:45:33-604434 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 23 23:45:33-604466 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/ats.conf' Feb 23 23:45:33-604515 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 23 23:45:33-604547 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat.conf' Feb 23 23:45:33-604574 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 23 23:45:33-604605 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nat-auto.conf' Feb 23 23:45:33-604624 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 23 23:45:33-604656 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/transport.conf' Feb 23 23:45:33-604755 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 23 23:45:33-604788 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/communicator-unix.conf' Feb 23 23:45:33-604799 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 23 23:45:33-604830 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/core.conf' Feb 23 23:45:33-604849 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 23 23:45:33-604882 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed-logger.conf' Feb 23 23:45:33-604953 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 23 23:45:33-604986 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/testbed.conf' Feb 23 23:45:33-605042 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 23 23:45:33-605074 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/nse.conf' Feb 23 23:45:33-605104 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 23 23:45:33-605136 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dht.conf' Feb 23 23:45:33-605161 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 23 23:45:33-605193 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/hostlist.conf' Feb 23 23:45:33-605216 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 23 23:45:33-605248 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/topology.conf' Feb 23 23:45:33-605263 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 23 23:45:33-605304 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/regex.conf' Feb 23 23:45:33-605320 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 23 23:45:33-605352 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/dns.conf' Feb 23 23:45:33-605378 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 23 23:45:33-605410 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/identity.conf' Feb 23 23:45:33-605429 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 23 23:45:33-605460 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namecache.conf' Feb 23 23:45:33-605486 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 23 23:45:33-605517 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/namestore.conf' Feb 23 23:45:33-605551 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 23 23:45:33-605583 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/cadet.conf' Feb 23 23:45:33-605614 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 23 23:45:33-605646 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/set.conf' Feb 23 23:45:33-605662 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 23 23:45:33-605694 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/consensus.conf' Feb 23 23:45:33-605710 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 23 23:45:33-605741 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/scalarproduct.conf' Feb 23 23:45:33-605763 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 23 23:45:33-605795 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/revocation.conf' Feb 23 23:45:33-605814 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 23 23:45:33-605846 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/vpn.conf' Feb 23 23:45:33-605866 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 23 23:45:33-605898 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/gns.conf' Feb 23 23:45:33-605934 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 23 23:45:33-605966 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/zonemaster.conf' Feb 23 23:45:33-605995 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 23 23:45:33-606026 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/conversation.conf' Feb 23 23:45:33-606049 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 23 23:45:33-606081 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/fs.conf' Feb 23 23:45:33-606126 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 23 23:45:33-606158 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/exit.conf' Feb 23 23:45:33-606196 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 23 23:45:33-606228 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/pt.conf' Feb 23 23:45:33-606247 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 23 23:45:33-606283 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/secretsharing.conf' Feb 23 23:45:33-606309 util-6752 DEBUG Asked to parse config file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 23 23:45:33-606342 util-6752 DEBUG Deserializing contents of file `/home/ng0/opt/share/gnunet/config.d/rest.conf' Feb 23 23:45:33-606365 util-6752 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 23 23:45:33-606399 util-6752 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 23 23:45:33-606410 util-6752 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 23 23:45:33-606459 util-6752 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_forcestart.conf' Feb 23 23:45:33-606495 util-6752 DEBUG Asked to parse config file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 23 23:45:33-606540 util-6752 DEBUG Deserializing contents of file `/home/ng0/src/gnunet/gnunet/src/arm/../../contrib/conf/gnunet/no_autostart_above_core.conf' Feb 23 23:45:33-606668 util-6752 DEBUG Failed to retrieve filename Feb 23 23:45:33-606678 util-service-6752 DEBUG Service `resolver' runs with configuration from `/home/ng0/src/gnunet/gnunet/src/arm/test_arm_api_data.conf' Feb 23 23:45:33-606709 util-scheduler-6752 DEBUG Registering signal handlers Feb 23 23:45:33-606741 util-scheduler-6752 DEBUG Adding task 0x6faef191e080 Feb 23 23:45:33-606756 util-scheduler-6752 DEBUG Adding continuation task 0x6faef191e160 Feb 23 23:45:33-606767 util-scheduler-6752 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-606782 util-scheduler-6752 DEBUG Running task 0x6faef191e080 Feb 23 23:45:33-606792 util-os-priority-6752 DEBUG Not installing a handler because $GNUNET_OS_CONTROL_PIPE is empty Feb 23 23:45:33-606805 util-scheduler-6752 DEBUG destroying task 0x6faef191e080 Feb 23 23:45:33-606814 util-scheduler-6752 DEBUG Running task 0x6faef191e160 Feb 23 23:45:33-606823 util-scheduler-6752 DEBUG Adding shutdown task 0x6faef191e080 Feb 23 23:45:33-606875 util-scheduler-6752 DEBUG Adding shutdown task 0x6faef191e320 Feb 23 23:45:33-606915 resolver-6752 DEBUG Adding DNS server '192.168.1.1': success Feb 23 23:45:33-606925 resolver-6752 DEBUG Adding DNS server 'fda9:652b:4324::1': success Feb 23 23:45:33-606933 util-scheduler-6752 DEBUG destroying task 0x6faef191e160 Feb 23 23:45:33-606943 util-scheduler-6752 DEBUG select timeout = end of time Feb 23 23:45:33-606955 util-scheduler-6752 DEBUG Running task 0x6faef191e1d0 Feb 23 23:45:33-606968 util-network-6752 DEBUG Accepting connection on `/tmp/gnunet-system-runtime//gnunet-service-resolver.sock' Feb 23 23:45:33-606987 util-service-6752 DEBUG Service accepted incoming connection from  . Feb 23 23:45:33-607002 util-network-6752 DEBUG Accepting connection on `/tmp/gnunet-system-runtime//gnunet-service-resolver.sock' Feb 23 23:45:33-607012 util-scheduler-6752 DEBUG destroying task 0x6faef191e1d0 Feb 23 23:45:33-607022 util-scheduler-6752 DEBUG select timeout = end of time Feb 23 23:45:33-607033 util-scheduler-6752 DEBUG Running task 0x6faef191e160 Feb 23 23:45:33-607047 util-mst-6752 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 23 23:45:33-607057 util-scheduler-6752 DEBUG destroying task 0x6faef191e160 Feb 23 23:45:33-607067 util-scheduler-6752 DEBUG select timeout = end of time Feb 23 23:45:33-607076 util-scheduler-6752 DEBUG Running task 0x6faef191e1d0 Feb 23 23:45:33-607086 util-mst-6752 DEBUG MST receives 0 bytes with 27 bytes already in private buffer Feb 23 23:45:33-607094 util-service-6752 DEBUG Received message of type 4 and size 27 from client Feb 23 23:45:33-607104 util-scheduler-6752 DEBUG Adding task 0x6faef191e160 Feb 23 23:45:33-607114 util-mq-6752 DEBUG Received message of type 4 and size 27 Feb 23 23:45:33-607125 util-scheduler-6752 DEBUG canceling task 0x6faef191e160 Feb 23 23:45:33-607133 util-scheduler-6752 DEBUG destroying task 0x6faef191e160 Feb 23 23:45:33-607152 util-scheduler-6752 DEBUG Adding task 0x6faef191e160 Feb 23 23:45:33-607164 resolver-6752 DEBUG No cache entry for 'uptimegirl' Feb 23 23:45:33-607172 resolver-6752 DEBUG resolve_and_cache `uptimegirl' Feb 23 23:45:33-607271 util-scheduler-6752 DEBUG Adding task 0x6faef191e400 Feb 23 23:45:33-607284 util-scheduler-6752 DEBUG Adding task 0x6faef191e470 Feb 23 23:45:33-607293 resolver-6752 DEBUG Resolving uptimegirl, client_request_id = 1, dns_id = 56770 Feb 23 23:45:33-607302 util-mst-6752 DEBUG Server-mst leaves 0 bytes in private buffer Feb 23 23:45:33-607310 util-scheduler-6752 DEBUG destroying task 0x6faef191e1d0 Feb 23 23:45:33-607321 util-scheduler-6752 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-607332 util-scheduler-6752 DEBUG Running task 0x6faef191e470 Feb 23 23:45:33-607341 util-scheduler-6752 DEBUG Adding task 0x6faef191e1d0 Feb 23 23:45:33-607394 resolver-6752 DEBUG Sent DNS request to [fda9:652b:4324::1]:53 Feb 23 23:45:33-607409 util-scheduler-6752 DEBUG Adding task 0x6faef191e4e0 Feb 23 23:45:33-607418 util-scheduler-6752 DEBUG destroying task 0x6faef191e470 Feb 23 23:45:33-607426 util-scheduler-6752 DEBUG Running task 0x6faef191e160 Feb 23 23:45:33-607434 util-mst-6752 DEBUG MST receives 0 bytes with 0 bytes already in private buffer Feb 23 23:45:33-607442 util-mst-6752 DEBUG Server-mst leaves 0 bytes in private buffer Feb 23 23:45:33-607451 util-scheduler-6752 DEBUG destroying task 0x6faef191e160 Feb 23 23:45:33-607461 util-scheduler-6752 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-615854 util-scheduler-6752 DEBUG Running task 0x6faef191e4e0 Feb 23 23:45:33-615866 resolver-6752 DEBUG Receiving 72 byte DNS reply Feb 23 23:45:33-615897 resolver-6752 DEBUG Got reply for hostname uptimegirl and request ID 1 Feb 23 23:45:33-615916 util-scheduler-6752 DEBUG canceling task 0x6faef191e1d0 Feb 23 23:45:33-615925 util-scheduler-6752 DEBUG destroying task 0x6faef191e1d0 Feb 23 23:45:33-615935 util-scheduler-6752 DEBUG Adding task 0x6faef191e160 Feb 23 23:45:33-615947 util-scheduler-6752 DEBUG Adding task 0x6faef191e1d0 Feb 23 23:45:33-615956 util-scheduler-6752 DEBUG destroying task 0x6faef191e4e0 Feb 23 23:45:33-615967 util-scheduler-6752 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-615978 util-scheduler-6752 DEBUG Running task 0x6faef191e160 Feb 23 23:45:33-615987 util-scheduler-6752 DEBUG Adding task 0x6faef191e4e0 Feb 23 23:45:33-616016 resolver-6752 DEBUG Sent DNS request to [fda9:652b:4324::1]:53 Feb 23 23:45:33-616027 util-scheduler-6752 DEBUG Adding task 0x6faef191e550 Feb 23 23:45:33-616035 util-scheduler-6752 DEBUG destroying task 0x6faef191e160 Feb 23 23:45:33-616045 util-scheduler-6752 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-618009 util-scheduler-6752 DEBUG Running task 0x6faef191e550 Feb 23 23:45:33-618018 resolver-6752 DEBUG Receiving 112 byte DNS reply Feb 23 23:45:33-618039 resolver-6752 DEBUG Got reply for hostname uptimegirl and request ID 1 Feb 23 23:45:33-618053 resolver-6752 DEBUG No cache entry for 'uptimegirl' Feb 23 23:45:33-618061 resolver-6752 DEBUG Sending END message Feb 23 23:45:33-618071 util-mq-6752 DEBUG sending message of type 5, queue empty (MQ: 0x6faef19371e0) Feb 23 23:45:33-618080 util-service-6752 DEBUG Sending message of type 5 and size 8 to client Feb 23 23:45:33-618089 util-scheduler-6752 DEBUG canceling task 0x6faef191e4e0 Feb 23 23:45:33-618097 util-scheduler-6752 DEBUG destroying task 0x6faef191e4e0 Feb 23 23:45:33-618106 util-scheduler-6752 DEBUG canceling task 0x6faef191e400 Feb 23 23:45:33-618114 util-scheduler-6752 DEBUG destroying task 0x6faef191e400 Feb 23 23:45:33-618124 util-scheduler-6752 DEBUG Adding task 0x6faef191e400 Feb 23 23:45:33-618132 util-scheduler-6752 DEBUG destroying task 0x6faef191e550 Feb 23 23:45:33-618142 util-scheduler-6752 DEBUG select timeout = end of time Feb 23 23:45:33-618153 util-scheduler-6752 DEBUG Running task 0x6faef191e160 Feb 23 23:45:33-618161 util-service-6752 DEBUG service: sending message with type 5Feb 23 23:45:33-618187 util-scheduler-6752 DEBUG Adding task 0x6faef191e4e0 Feb 23 23:45:33-618189 util-scheduler-12332 DEBUG Running task 0x6fe30d31e320 Feb 23 23:45:33-618196 util-scheduler-6752 DEBUG destroying task 0x6faef191e160 Feb 23 23:45:33-618203 util-mst-12332 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 23 23:45:33-618207 util-scheduler-6752 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-618213 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e320 Feb 23 23:45:33-618218 util-scheduler-6752 DEBUG Running task 0x6faef191e4e0 Feb 23 23:45:33-618223 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:43 2019 Feb 23 23:45:33-618227 util-scheduler-6752 DEBUG destroying task 0x6faef191e4e0 Feb 23 23:45:33-618233 util-scheduler-12332 DEBUG Running task 0x6fe30d31e1d0 Feb 23 23:45:33-618237 util-scheduler-6752 DEBUG select timeout = end of time Feb 23 23:45:33-618242 util-mst-12332 DEBUG MST receives 0 bytes with 8 bytes already in private buffer Feb 23 23:45:33-618251 util-client-12332 DEBUG Received message of type 5 and size 8 from resolver Feb 23 23:45:33-618259 util-mq-12332 DEBUG Received message of type 5 and size 8 Feb 23 23:45:33-618267 util-resolver-api-12332 DEBUG Received empty response from DNS service Feb 23 23:45:33-618276 test-gnunet-service-arm-12332 ERROR Failed to resolve our own hostname! Feb 23 23:45:33-618286 test-gnunet-service-arm-12332 ERROR Assertion failed at test_gnunet_service_arm.c:118. Feb 23 23:45:33-618295 arm-api-12332 DEBUG Stopping service `arm' Feb 23 23:45:33-618306 util-mq-12332 DEBUG sending message of type 9, queue empty (MQ: 0x6fe30d338150) Feb 23 23:45:33-618316 util-resolver-api-12332 DEBUG Asked to cancel request to resolve hostname `uptimegirl'. Feb 23 23:45:33-618326 util-scheduler-12332 DEBUG canceling task 0x6fe30d31e2b0 Feb 23 23:45:33-618333 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e2b0 Feb 23 23:45:33-618342 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e160 Feb 23 23:45:33-618350 util-mst-12332 DEBUG Server-mst leaves 0 bytes in private buffer Feb 23 23:45:33-618358 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e1d0 Feb 23 23:45:33-618368 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-618378 util-scheduler-12332 DEBUG Running task 0x6fe30d31e320 Feb 23 23:45:33-618386 util-client-12332 DEBUG message of type 9 trying to send with socket 0x6fe30d347680 (MQ: 0x6fe30d338150 Feb 23 23:45:33-618405 util-scheduler-3003 DEBUG Running task 0x71ce063211d0 Feb 23 23:45:33-618419 util-mst-3003 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 23 23:45:33-618434 util-scheduler-3003 DEBUG destroying task 0x71ce063211d0 Feb 23 23:45:33-618445 util-scheduler-3003 DEBUG select timeout = end of time Feb 23 23:45:33-618455 util-scheduler-3003 DEBUG Running task 0x71ce06321080 Feb 23 23:45:33-618464 util-mst-3003 DEBUG MST receives 0 bytes with 20 bytes already in private buffer Feb 23 23:45:33-618472 util-service-3003 DEBUG Received message of type 9 and size 20 from client Feb 23 23:45:33-618481 util-scheduler-3003 DEBUG Adding task 0x71ce063211d0 Feb 23 23:45:33-618489 util-mq-3003 DEBUG Received message of type 9 and size 20 Feb 23 23:45:33-618501 arm-5556 INFO Preparing to stop `arm' Feb 23 23:45:33-618509 util-scheduler-3003 DEBUG canceling task 0x71ce063211d0 Feb 23 23:45:33-618517 util-scheduler-3003 DEBUG destroying task 0x71ce063211d0 Feb 23 23:45:33-618525 util-scheduler-3003 DEBUG Adding task 0x71ce063211d0 Feb 23 23:45:33-618533 arm-5556 DEBUG Sending status 3 of service `arm' to client Feb 23 23:45:33-618543 util-mq-3003 DEBUG sending message of type 10, queue empty (MQ: 0x71ce063370c0) Feb 23 23:45:33-618551 util-service-3003 DEBUG Sending message of type 10 and size 24 to client Feb 23 23:45:33-618561 util-scheduler-3003 DEBUG Adding task 0x71ce06322c10 Feb 23 23:45:33-618569 util-mst-3003 DEBUG Server-mst leaves 0 bytes in private buffer Feb 23 23:45:33-618577 util-scheduler-3003 DEBUG destroying task 0x71ce06321080 Feb 23 23:45:33-618647 util-scheduler-3003 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-618658 util-scheduler-3003 DEBUG Running task 0x71ce06322c10 Feb 23 23:45:33-618665 arm-5556 DEBUG Triggering shutdown Feb 23 23:45:33-618673 util-scheduler-3003 DEBUG GNUNET_SCHEDULER_shutdown Feb 23 23:45:33-618680 util-scheduler-3003 DEBUG canceling task 0x71ce06321160 Feb 23 23:45:33-618687 util-scheduler-3003 DEBUG destroying task 0x71ce06321160 Feb 23 23:45:33-618694 util-scheduler-3003 DEBUG destroying task 0x71ce06322c10 Feb 23 23:45:33-618701 util-scheduler-3003 DEBUG Running task 0x71ce063211d0 Feb 23 23:45:33-618708 util-mst-3003 DEBUG MST receives 0 bytes with 0 bytes already in private buffer Feb 23 23:45:33-618715 util-mst-3003 DEBUG Server-mst leaves 0 bytes in private buffer Feb 23 23:45:33-618723 util-scheduler-3003 DEBUG destroying task 0x71ce063211d0 Feb 23 23:45:33-618730 util-scheduler-3003 DEBUG Running task 0x71ce06322ba0 Feb 23 23:45:33-618737 util-service-3003 DEBUG service: sending message with type 10Feb 23 23:45:33-618764 util-client-12332 DEBUG sending message of type 9 successful Feb 23 23:45:33-618776 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e1d0 Feb 23 23:45:33-618785 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e320 Feb 23 23:45:33-618795 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-618805 util-scheduler-12332 DEBUG Running task 0x6fe30d31e1d0 Feb 23 23:45:33-618812 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e1d0 Feb 23 23:45:33-618819 util-scheduler-12332 DEBUG Running task 0x6fe30d31e240 Feb 23 23:45:33-618828 util-mst-12332 DEBUG MST receives 0 bytes with 4 bytes already in private buffer Feb 23 23:45:33-618836 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e240 Feb 23 23:45:33-618845 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-618854 util-scheduler-12332 DEBUG Running task 0x6fe30d31e1d0 Feb 23 23:45:33-618862 util-mst-12332 DEBUG MST receives 0 bytes with 24 bytes already in private buffer Feb 23 23:45:33-618869 util-client-12332 DEBUG Received message of type 10 and size 24 from arm Feb 23 23:45:33-618876 util-mq-12332 DEBUG Received message of type 10 and size 24 Feb 23 23:45:33-618885 util-mst-12332 DEBUG Server-mst leaves 0 bytes in private buffer Feb 23 23:45:33-618892 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e1d0 Feb 23 23:45:33-618901 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-618915 util-scheduler-3003 DEBUG Adding task 0x71ce06321160 Feb 23 23:45:33-618926 util-scheduler-3003 DEBUG destroying task 0x71ce06322ba0 Feb 23 23:45:33-618935 util-scheduler-3003 DEBUG scheduler has more tasks ready! Feb 23 23:45:33-618945 util-scheduler-3003 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-618955 util-scheduler-3003 DEBUG Running task 0x71ce06321240 Feb 23 23:45:33-618962 arm-5556 DEBUG First shutdown phase Feb 23 23:45:33-619029 util-scheduler-3003 DEBUG canceling task 0x71ce063229e0 Feb 23 23:45:33-619038 util-scheduler-3003 DEBUG destroying task 0x71ce063229e0 Feb 23 23:45:33-619089 util-scheduler-3003 DEBUG canceling task 0x71ce063225f0 Feb 23 23:45:33-619098 util-scheduler-3003 DEBUG destroying task 0x71ce063225f0 Feb 23 23:45:33-619142 util-scheduler-3003 DEBUG canceling task 0x71ce06322430 Feb 23 23:45:33-619151 util-scheduler-3003 DEBUG destroying task 0x71ce06322430 Feb 23 23:45:33-619300 arm-5556 INFO Stopping service `resolver' Feb 23 23:45:33-619311 util-os-priority-3003 DEBUG Sending signal 15 to pid: 6752 via system call Feb 23 23:45:33-619327 arm-5556 DEBUG resolver Feb 23 23:45:33-619333 arm-5556 DEBUG Delaying shutdown, have 1 childs still running Feb 23 23:45:33-619334 util-scheduler-6752 DEBUG select timeout = end of time Feb 23 23:45:33-619341 util-scheduler-3003 DEBUG destroying task 0x71ce06321240 Feb 23 23:45:33-619345 util-scheduler-6752 DEBUG Running task 0x6faef191e0f0 Feb 23 23:45:33-619348 util-scheduler-3003 DEBUG scheduler has more tasks ready! Feb 23 23:45:33-619355 util-scheduler-6752 DEBUG GNUNET_SCHEDULER_shutdown Feb 23 23:45:33-619357 util-scheduler-3003 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-619373 util-scheduler-6752 DEBUG destroying task 0x6faef191e0f0 Feb 23 23:45:33-619376 util-scheduler-3003 DEBUG Running task 0x71ce06321160 Feb 23 23:45:33-619382 util-scheduler-6752 DEBUG scheduler has more tasks ready! Feb 23 23:45:33-619384 util-scheduler-3003 DEBUG destroying task 0x71ce06321160 Feb 23 23:45:33-619391 util-scheduler-6752 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-619393 util-scheduler-3003 DEBUG select timeout = end of time Feb 23 23:45:33-619402 util-scheduler-6752 DEBUG Running task 0x6faef191e080 Feb 23 23:45:33-619410 util-scheduler-6752 DEBUG canceling task 0x6faef191e390 Feb 23 23:45:33-619418 util-scheduler-6752 DEBUG destroying task 0x6faef191e390 Feb 23 23:45:33-619425 util-scheduler-6752 DEBUG canceling task 0x6faef191e240 Feb 23 23:45:33-619433 util-scheduler-6752 DEBUG destroying task 0x6faef191e240 Feb 23 23:45:33-619440 util-scheduler-6752 DEBUG canceling task 0x6faef191e2b0 Feb 23 23:45:33-619447 util-scheduler-6752 DEBUG destroying task 0x6faef191e2b0 Feb 23 23:45:33-619455 resolver-6752 DEBUG Client dropped: 0x6faef1930080 (MQ: 0x6faef19371e0) Feb 23 23:45:33-619463 util-scheduler-6752 DEBUG canceling task 0x6faef191e470 Feb 23 23:45:33-619470 util-scheduler-6752 DEBUG destroying task 0x6faef191e470 Feb 23 23:45:33-619479 util-scheduler-6752 DEBUG Adding task 0x6faef191e0f0 Feb 23 23:45:33-619486 util-scheduler-6752 DEBUG destroying task 0x6faef191e080 Feb 23 23:45:33-619493 util-scheduler-6752 DEBUG Running task 0x6faef191e320 Feb 23 23:45:33-619507 util-scheduler-6752 DEBUG canceling task 0x6faef191e1d0 Feb 23 23:45:33-619515 util-scheduler-6752 DEBUG destroying task 0x6faef191e1d0 Feb 23 23:45:33-619524 util-scheduler-6752 DEBUG canceling task 0x6faef191e400 Feb 23 23:45:33-619532 util-scheduler-6752 DEBUG destroying task 0x6faef191e400 Feb 23 23:45:33-619539 util-scheduler-6752 DEBUG destroying task 0x6faef191e320 Feb 23 23:45:33-619547 util-scheduler-6752 DEBUG GNUNET_SCHEDULER_shutdown Feb 23 23:45:33-619554 util-scheduler-6752 DEBUG canceling task 0x6faef191e160 Feb 23 23:45:33-619561 util-scheduler-6752 DEBUG destroying task 0x6faef191e160 Feb 23 23:45:33-619571 util-scheduler-6752 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-619580 util-scheduler-6752 DEBUG Running task 0x6faef191e0f0 Feb 23 23:45:33-619592 util-scheduler-6752 DEBUG destroying task 0x6faef191e0f0 Feb 23 23:45:33-619600 util-scheduler-6752 DEBUG GNUNET_SCHEDULER_shutdown Feb 23 23:45:33-619599 util-scheduler-12332 DEBUG Running task 0x6fe30d31e160 Feb 23 23:45:33-619612 util-resolver-api-12332 DEBUG Disconnecting from DNS service Feb 23 23:45:33-619621 util-scheduler-12332 DEBUG canceling task 0x6fe30d31e2b0 Feb 23 23:45:33-619630 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e2b0 Feb 23 23:45:33-619638 util-client-12332 DEBUG destroying socket: 0x6fe30d3476a0 Feb 23 23:45:33-619648 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e160 Feb 23 23:45:33-619658 util-scheduler-12332 DEBUG select timeout = end of time Feb 23 23:45:33-619875 util-scheduler-3003 DEBUG select timeout = end of time Feb 23 23:45:33-619887 util-scheduler-3003 DEBUG Running task 0x71ce063212b0 Feb 23 23:45:33-619910 arm-5556 INFO Service `resolver' took 598 µs to terminate Feb 23 23:45:33-619919 arm-5556 DEBUG Sending status 1 of service `resolver' to client Feb 23 23:45:33-619928 arm-5556 DEBUG Last shutdown phase Feb 23 23:45:33-619936 util-scheduler-3003 DEBUG canceling task 0x71ce06322cf0 Feb 23 23:45:33-619944 util-scheduler-3003 DEBUG destroying task 0x71ce06322cf0 Feb 23 23:45:33-619952 arm-5556 DEBUG Client dropped: 0x71ce06333080 (MQ: 0x71ce063370c0) Feb 23 23:45:33-619959 util-scheduler-3003 DEBUG canceling task 0x71ce06321080 Feb 23 23:45:33-619966 util-scheduler-3003 DEBUG destroying task 0x71ce06321080 Feb 23 23:45:33-619974 util-scheduler-3003 DEBUG Adding task 0x71ce06321080 Feb 23 23:45:33-619981 util-scheduler-3003 DEBUG canceling task 0x71ce06321160 Feb 23 23:45:33-619998 util-scheduler-3003 DEBUG destroying task 0x71ce06321160 Feb 23 23:45:33-620006 util-scheduler-3003 DEBUG destroying task 0x71ce063212b0 Feb 23 23:45:33-620016 util-scheduler-3003 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-620025 util-scheduler-3003 DEBUG Running task 0x71ce06321080 Feb 23 23:45:33-620038 util-scheduler-3003 DEBUG destroying task 0x71ce06321080 Feb 23 23:45:33-620047 util-scheduler-3003 DEBUG GNUNET_SCHEDULER_shutdown Feb 23 23:45:33-620067 util-3003 DEBUG Failed to retrieve filename Feb 23 23:45:33-620600 util-scheduler-12332 DEBUG Running task 0x6fe30d31e240 Feb 23 23:45:33-620618 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e160 Feb 23 23:45:33-620632 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e1d0 Feb 23 23:45:33-620643 util-client-12332 DEBUG destroying socket: 0x6fe30d347680 Feb 23 23:45:33-620657 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e240 Feb 23 23:45:33-620668 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-620678 util-scheduler-12332 DEBUG Running task 0x6fe30d31e1d0 Feb 23 23:45:33-620689 util-12332 DEBUG Asked to $-expand $GNUNET_USER_RUNTIME_DIR/gnunet-service-arm.sock Feb 23 23:45:33-620696 util-12332 DEBUG Split into `GNUNET_USER_RUNTIME_DIR' and `gnunet-service-arm.sock' with default (null) Feb 23 23:45:33-620706 util-12332 DEBUG Asked to $-expand ${TMPDIR:-${TMP:-/tmp}}/gnunet-${USERHOME:-${USER:-user}}-runtime/ Feb 23 23:45:33-620714 util-12332 DEBUG Split into `TMPDIR' and `/gnunet-${USERHOME:-${USER:-user}}-runtime/' with default ${TMP:-/tmp} Feb 23 23:45:33-620722 util-12332 DEBUG Asked to $-expand ${TMP:-/tmp} Feb 23 23:45:33-620730 util-12332 DEBUG Split into `TMP' and `' with default /tmp Feb 23 23:45:33-620740 util-12332 DEBUG Asked to $-expand ${USERHOME:-${USER:-user}}-runtime/ Feb 23 23:45:33-620748 util-12332 DEBUG Split into `USERHOME' and `-runtime/' with default ${USER:-user} Feb 23 23:45:33-620756 util-12332 DEBUG Asked to $-expand ${USER:-user} Feb 23 23:45:33-620764 util-12332 DEBUG Split into `USER' and `' with default user Feb 23 23:45:33-620776 util-scheduler-12332 DEBUG Adding task 0x6fe30d31e240 Feb 23 23:45:33-620785 arm-api-12332 DEBUG Sending TEST message to ARM Feb 23 23:45:33-620793 util-mq-12332 DEBUG sending message of type 15, queue empty (MQ: 0x6fe30d338150) Feb 23 23:45:33-620800 util-client-12332 DEBUG message of type 15 waiting for socket Feb 23 23:45:33-620807 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e1d0 Feb 23 23:45:33-620815 util-scheduler-12332 DEBUG Running task 0x6fe30d31e160 Feb 23 23:45:33-620823 arm-api-12332 DEBUG Disconnecting from ARM service Feb 23 23:45:33-620830 util-scheduler-12332 DEBUG canceling task 0x6fe30d31e240 Feb 23 23:45:33-620838 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e240 Feb 23 23:45:33-620846 util-mq-12332 DEBUG MQ destroy drops current message of type 15 Feb 23 23:45:33-620854 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e160 Feb 23 23:45:33-620862 util-scheduler-12332 DEBUG GNUNET_SCHEDULER_shutdown Feb 23 23:45:33-620869 util-scheduler-12332 DEBUG canceling task 0x6fe30d31e0f0 Feb 23 23:45:33-620876 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e0f0 Feb 23 23:45:33-620884 util-scheduler-12332 DEBUG scheduler has more tasks ready! Feb 23 23:45:33-620893 util-scheduler-12332 DEBUG select timeout = Sat Feb 23 23:45:33 2019 Feb 23 23:45:33-620902 util-scheduler-12332 DEBUG Running task 0x6fe30d31e080 Feb 23 23:45:33-620910 util-scheduler-12332 DEBUG destroying task 0x6fe30d31e080 Feb 23 23:45:33-620917 util-scheduler-12332 DEBUG GNUNET_SCHEDULER_shutdown Test failed with error code 3 FAIL test_gnunet_service_arm (exit status: 3)