Page 1 of 1

Zeroconf_lookup() failed

Posted: Thu Aug 27, 2020 2:55 am
by luneart
Hello,

I have errors trying to connect since yesterday, but to my knowledge I haven't modified anything - nor code, nor firmware of the (network) hub, nor system updates (before, I had disconnection issues when it ran for several tens of minutes, but it did connect, every time).

I have HUB5000(s) which used to connect either through ethernet or wifi. I can still access their web interfaces by their IP (static) as I used to do (I have one such hub connected through both interfaces right now).

The only significant thing I did between yesterday morning (connecting) and yesterday evening (not connecting) was to boot in windows to access the phidget control panel, in order to upgrade the firmware of a DCC1100 newly connected to a hub (btw, is there any way to do that in linux?).

Here is the phidget log:

Code: Select all

2020-08-27T10:43:29  <Info> phidget22 : 
	******************************  Logging Enabled  ******************************
	* Phidget22 - Version 1.6 - Built Jul  8 2020 16:08:44                        *
	*******************************************************************************
2020-08-27T10:43:29  <Info> phidget22net[PhidgetNet_start()] : Starting Networking
2020-08-27T10:43:29  <Info> phidget22usb[PhidgetUSBScanDevices()] : Initializing libusb
2020-08-27T10:43:29  <Info> phidget22net[deviceServerListener()] : Discovered server 'hub5000' [hub5000] (interface 0x5)
2020-08-27T10:43:29  <Info> phidget22netctl[PhidgetNet_discoveredServer()] : Discovered Server: hub5000
2020-08-27T10:43:29  <Info> phidget22net[deviceServerListener()] : Discovered server 'hub5000' [hub5000] (interface 0x4)
2020-08-27T10:43:29  <Info> phidget22netctl[PhidgetNet_discoveredServer()] : Discovered Server: hub5000
2020-08-27T10:43:29  <Info> phidget22netctl[runNetworkControlEntry()] : network control entry thread started - hub5000: 0xa1223700
2020-08-27T10:43:29  <Info> phidget22netctl[runNetworkControlEntry()] : network control entry hub5000 not connected (failures=0)
2020-08-27T10:43:29  <Info> phidget22netctl[PhidgetNet_discoveredServer()] : network control entry for hub5000 rediscovered
2020-08-27T10:43:29  <Info> phidget22net[deviceServerListener()] : Discovered server 'hub5000' [hub5000] (interface 0x4)
2020-08-27T10:43:29  <Info> phidget22netctl[PhidgetNet_discoveredServer()] : Discovered Server: hub5000
2020-08-27T10:43:29  <Info> phidget22netctl[PhidgetNet_discoveredServer()] : network control entry for hub5000 rediscovered
2020-08-27T10:43:29  <Info> phidget22net[deviceServerListener()] : Discovered server 'hub5000' [hub5000] (interface 0x5)
2020-08-27T10:43:29  <Info> phidget22netctl[PhidgetNet_discoveredServer()] : Discovered Server: hub5000
2020-08-27T10:43:29  <Info> phidget22netctl[PhidgetNet_discoveredServer()] : network control entry for hub5000 rediscovered
2020-08-27T10:43:34  <Info> phidget22[DNSServiceResolve_Callback()] : Failed to resolve service 'hub5000' of type '_phidget22server._tcp' in domain 'local.': Timeout reached
2020-08-27T10:43:34 <ERROR> phidget22netctl[runNetworkControlEntry()] : Zeroconf_lookup() failed for host 'hub5000 [hub5000]' on interface 0x5: 0x1c - Unexpected Error
2020-08-27T10:43:36  <Info> phidget22netctl[runNetworkControlEntry()] : network control entry hub5000 not connected (failures=1)
2020-08-27T10:43:41  <Info> phidget22[DNSServiceResolve_Callback()] : Failed to resolve service 'hub5000' of type '_phidget22server._tcp' in domain 'local.': Timeout reached
2020-08-27T10:43:41 <ERROR> phidget22netctl[runNetworkControlEntry()] : Zeroconf_lookup() failed for host 'hub5000 [hub5000]' on interface 0x5: 0x1c - Unexpected Error
2020-08-27T10:43:45  <Info> phidget22netctl[runNetworkControlEntry()] : network control entry hub5000 not connected (failures=2)
2020-08-27T10:43:50  <Info> phidget22[DNSServiceResolve_Callback()] : Failed to resolve service 'hub5000' of type '_phidget22server._tcp' in domain 'local.': Timeout reached
2020-08-27T10:43:50 <ERROR> phidget22netctl[runNetworkControlEntry()] : Zeroconf_lookup() failed for host 'hub5000 [hub5000]' on interface 0x5: 0x1c - Unexpected Error
2020-08-27T10:43:58  <Info> phidget22netctl[runNetworkControlEntry()] : network control entry hub5000 not connected (failures=3)
2020-08-27T10:44:03  <Info> phidget22[DNSServiceResolve_Callback()] : Failed to resolve service 'hub5000' of type '_phidget22server._tcp' in domain 'local.': Timeout reached
2020-08-27T10:44:03 <ERROR> phidget22netctl[runNetworkControlEntry()] : Zeroconf_lookup() failed for host 'hub5000 [hub5000]' on interface 0x5: 0x1c - Unexpected Error
2020-08-27T10:44:19  <Info> phidget22netctl[runNetworkControlEntry()] : network control entry hub5000 not connected (failures=4)
2020-08-27T10:44:24  <Info> phidget22[DNSServiceResolve_Callback()] : Failed to resolve service 'hub5000' of type '_phidget22server._tcp' in domain 'local.': Timeout reached
2020-08-27T10:44:24 <ERROR> phidget22netctl[runNetworkControlEntry()] : Zeroconf_lookup() failed for host 'hub5000 [hub5000]' on interface 0x5: 0x1c - Unexpected Error
And here is the system log from the hub (weird date/time though, I'd have expected to have entries in that log at every start of the device.... and I plug it in this morning before running my program, generating the "server" log above) :

Code: Select all

Mon Aug 24 15:53:50 2020 kern.debug kernel: [   19.310000] usb 2-1: no of_node; not parsing pinctrl DT
Mon Aug 24 15:53:52 2020 kern.warn kernel: [   21.200000] <==== rt28xx_init, Status=0
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface eth0.1.IPv6 with address fe80::9e65:f9ff:fe2a:e14b.
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: New relevant interface eth0.1.IPv6 for mDNS.
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface eth0.IPv6 with address fd84:958e:53f::1.
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: New relevant interface eth0.IPv6 for mDNS.
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.30.4.
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: New relevant interface eth0.IPv4 for mDNS.
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface ra0.IPv6 with address fe80::9e65:f9ff:fe2a:e14b.
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: New relevant interface ra0.IPv6 for mDNS.
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: Network interface enumeration completed.
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: Registering new address record for fe80::9e65:f9ff:fe2a:e14b on eth0.1.*.
Mon Aug 24 15:53:52 2020 daemon.info avahi-daemon[849]: Registering new address record for fd84:958e:53f::1 on eth0.*.
Mon Aug 24 15:53:52 2020 daemon.notice netifd: radio0 (771): Interface doesn't accept private ioctl...
Mon Aug 24 15:53:52 2020 daemon.notice netifd: radio0 (771): set (8BE2): Invalid argument
Mon Aug 24 15:53:53 2020 daemon.info avahi-daemon[849]: Server startup complete. Host name is hub5000.local. Local service cookie is 2607288958.
Mon Aug 24 15:53:53 2020 kern.info ap_client: apcli0 is not associated
Mon Aug 24 15:53:53 2020 kern.info ap_client: Scanning for networks...
Mon Aug 24 15:53:54 2020 daemon.info avahi-daemon[849]: Service "PhidgetSBC (9c:65:f9:2a:e1:4b)" (/etc/avahi/services/phidgetsbc.service) successfully established.
Mon Aug 24 15:53:54 2020 daemon.info dnsmasq[937]: started, version 2.79rc1 cachesize 150
Mon Aug 24 15:53:54 2020 daemon.info dnsmasq[937]: DNS service limited to local subnets
Mon Aug 24 15:53:54 2020 daemon.info dnsmasq[937]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC no-ID loop-detect inotify
Mon Aug 24 15:53:54 2020 daemon.info dnsmasq[937]: using local addresses only for domain lan
Mon Aug 24 15:53:54 2020 daemon.warn dnsmasq[937]: no servers found in /tmp/resolv.conf.auto, will retry
Mon Aug 24 15:53:54 2020 daemon.info dnsmasq[937]: read /etc/hosts - 1 addresses
Mon Aug 24 15:53:54 2020 daemon.info dnsmasq[937]: read /tmp/hosts/dhcp - 1 addresses
Mon Aug 24 15:53:54 2020 daemon.notice netifd: Network device 'ra0' link is up
Mon Aug 24 15:53:54 2020 daemon.notice netifd: Interface 'wifi' is enabled
Mon Aug 24 15:53:54 2020 daemon.notice netifd: Interface 'wifi' is setting up now
Mon Aug 24 15:53:54 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface ra0.IPv4 with address 192.168.100.1.
Mon Aug 24 15:53:54 2020 daemon.info avahi-daemon[849]: New relevant interface ra0.IPv4 for mDNS.
Mon Aug 24 15:53:54 2020 daemon.info avahi-daemon[849]: Registering new address record for 192.168.100.1 on ra0.IPv4.
Mon Aug 24 15:53:54 2020 daemon.notice netifd: Interface 'wifi' is now up
Mon Aug 24 15:53:54 2020 daemon.notice netifd: Interface 'wifi' has link connectivity 
Mon Aug 24 15:53:54 2020 daemon.notice netifd: Interface 'wificlient' is enabled
Mon Aug 24 15:53:54 2020 daemon.notice netifd: Interface 'wificlient' is setting up now
Mon Aug 24 15:53:54 2020 daemon.notice netifd: Interface 'wificlient' is now up
Mon Aug 24 15:53:54 2020 daemon.info dnsmasq[937]: reading /tmp/resolv.conf.auto
Mon Aug 24 15:53:54 2020 daemon.info dnsmasq[937]: using local addresses only for domain lan
Mon Aug 24 15:53:54 2020 daemon.info dnsmasq[937]: using nameserver 10.0.0.1#53
Mon Aug 24 15:53:56 2020 user.emerg syslog: setting up led ethlink
Mon Aug 24 15:53:56 2020 daemon.info procd: - init complete -
Mon Aug 24 15:53:57 2020 user.notice swplugd: Cable not detected - bringing lan DOWN
Mon Aug 24 15:53:57 2020 daemon.notice netifd: Interface 'lan' is now down
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Registering new address record for fe80::9e65:f9ff:fe2a:e14b on eth0.*.
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Withdrawing address record for 169.254.30.4 on eth0.
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.30.4.
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Interface eth0.IPv4 no longer relevant for mDNS.
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Interface eth0.IPv6 no longer relevant for mDNS.
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Leaving mDNS multicast group on interface eth0.IPv6 with address fd84:958e:53f::1.
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Withdrawing address record for fe80::9e65:f9ff:fe2a:e14b on eth0.
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Withdrawing address record for fd84:958e:53f::1 on eth0.
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Interface eth0.1.IPv6 no longer relevant for mDNS.
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Leaving mDNS multicast group on interface eth0.1.IPv6 with address fe80::9e65:f9ff:fe2a:e14b.
Mon Aug 24 15:53:57 2020 daemon.info avahi-daemon[849]: Withdrawing address record for fe80::9e65:f9ff:fe2a:e14b on eth0.1.
Mon Aug 24 15:53:57 2020 daemon.notice netifd: Interface 'lan' is disabled
Mon Aug 24 15:53:57 2020 daemon.notice netifd: Network device 'eth0' link is down
Mon Aug 24 15:53:57 2020 daemon.notice netifd: Interface 'lan' has link connectivity loss
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 1 DIRECT-51-HP OfficeJet Pro 7720 3e:52:82:88:22:51 WPA2PSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 1 freebox_SYLVIE d6:8b:5d:93:0f:4c WPAPSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 1 FreeWifi_secure d6:8b:5d:93:0f:4e WPA
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 2 FreeWifi_secure 68:a3:78:08:30:43 WPA2
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 3 FREEBOX_ALAIN_TZ 2a:bf:ef:12:cd:ac WPAPSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 3 FreeWifi_secure 14:0c:76:f0:a1:fa WPA2
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 4 cafard 00:24:d4:61:96:b4 WPA2PSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 4 FreeWifi_secure 00:24:d4:61:96:b6 WPA2
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 6 NETGEAR39 b0:39:56:f2:d3:2e WPA2PSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 6 NUMERICABLE-D8CC c0:d9:62:45:e7:57 WPA1PSKWPA2PSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 6 FreeWifi_secure 70:fc:8f:53:a7:32 WPA2
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 6 Extender-WiFi-33a1 30:d3:2d:43:33:a1 WPA2PSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 6 FreeWifi_secure f4:ca:e5:d6:f3:f2 WPA2
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 8 freebox_LBO e4:9e:12:19:f0:65 WPA2PSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 8 FreeWifi_secure e4:9e:12:19:f0:67 WPA2
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 9 Bbox-93138E 96:fe:f4:93:13:90 WPA1PSKWPA2PSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 11 SFR_5868 24:95:04:98:58:6c WPAPSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 11 Livebox-E5B2 b8:26:6c:fa:e5:b2 WPA1PSKWPA2PSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 13 lunearts 38:94:ed:f7:3d:f8 WPA2PSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network - 13 lunearts_2GEXT 14:59:c0:89:ab:d1 WPA2PSK
Mon Aug 24 15:53:58 2020 kern.info ap_client: Found network, trying to associate (essid: lunearts_2GEXT, bssid: 14:59:c0:89:ab:d1, channel: 13, enc: WPA2PSK, crypto: AES)
Mon Aug 24 15:53:58 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface apcli0.IPv4 with address 10.0.0.11.
Mon Aug 24 15:53:58 2020 daemon.notice netifd: Network device 'apcli0' link is up
Mon Aug 24 15:53:58 2020 daemon.info avahi-daemon[849]: New relevant interface apcli0.IPv4 for mDNS.
Mon Aug 24 15:53:58 2020 daemon.notice netifd: Interface 'wificlient' has link connectivity 
Mon Aug 24 15:53:58 2020 daemon.info avahi-daemon[849]: Registering new address record for 10.0.0.11 on apcli0.IPv4.
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[937]: exiting on receipt of SIGTERM
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[1085]: started, version 2.79rc1 cachesize 150
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[1085]: DNS service limited to local subnets
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[1085]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC no-ID loop-detect inotify
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq-dhcp[1085]: DHCP, IP range 192.168.100.100 -- 192.168.100.249, lease time 12h
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[1085]: using local addresses only for domain lan
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[1085]: reading /tmp/resolv.conf.auto
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[1085]: using local addresses only for domain lan
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[1085]: using nameserver 10.0.0.1#53
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[1085]: read /etc/hosts - 1 addresses
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[1085]: read /tmp/hosts/dhcp - 1 addresses
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq[1085]: read /tmp/hosts/odhcpd - 0 addresses
Mon Aug 24 15:53:59 2020 daemon.info dnsmasq-dhcp[1085]: read /etc/ethers - 0 addresses
Mon Aug 24 15:53:59 2020 user.notice firewall: Reloading firewall due to ifup of wifi (ra0)
Mon Aug 24 15:54:00 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface apcli0.IPv6 with address fe80::9c65:f9ff:fe0a:e14b.
Mon Aug 24 15:54:00 2020 daemon.info avahi-daemon[849]: New relevant interface apcli0.IPv6 for mDNS.
Mon Aug 24 15:54:00 2020 daemon.info avahi-daemon[849]: Registering new address record for fe80::9c65:f9ff:fe0a:e14b on apcli0.*.
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1085]: exiting on receipt of SIGTERM
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1152]: started, version 2.79rc1 cachesize 150
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1152]: DNS service limited to local subnets
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1152]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC no-ID loop-detect inotify
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq-dhcp[1152]: DHCP, IP range 192.168.100.100 -- 192.168.100.249, lease time 12h
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1152]: using local addresses only for domain lan
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1152]: reading /tmp/resolv.conf.auto
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1152]: using local addresses only for domain lan
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1152]: using nameserver 10.0.0.1#53
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1152]: read /etc/hosts - 1 addresses
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1152]: read /tmp/hosts/dhcp - 0 addresses
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq[1152]: read /tmp/hosts/odhcpd - 0 addresses
Mon Aug 24 15:54:00 2020 daemon.info dnsmasq-dhcp[1152]: read /etc/ethers - 0 addresses
Mon Aug 24 15:54:00 2020 user.notice firewall: Reloading firewall due to ifup of wificlient (apcli0)
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Withdrawing address record for fe80::9e65:f9ff:fe2a:e14b on ra0.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Withdrawing address record for 192.168.100.1 on ra0.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Withdrawing address record for fe80::9c65:f9ff:fe0a:e14b on apcli0.
Mon Aug 24 15:54:01 2020 daemon.warn avahi-daemon[849]: Host name conflict, retrying with hub5000-2
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Registering new address record for fe80::9e65:f9ff:fe2a:e14b on ra0.*.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Registering new address record for 192.168.100.1 on ra0.IPv4.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Registering new address record for fe80::9c65:f9ff:fe0a:e14b on apcli0.*.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Registering new address record for 10.0.0.11 on apcli0.IPv4.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Registering HINFO record with values 'MIPS'/'LINUX'.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Withdrawing address record for fe80::9e65:f9ff:fe2a:e14b on ra0.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Withdrawing address record for 192.168.100.1 on ra0.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Withdrawing address record for 10.0.0.11 on apcli0.
Mon Aug 24 15:54:01 2020 daemon.warn avahi-daemon[849]: Host name conflict, retrying with hub5000-3
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Registering new address record for fe80::9e65:f9ff:fe2a:e14b on ra0.*.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Registering new address record for 192.168.100.1 on ra0.IPv4.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Registering new address record for fe80::9c65:f9ff:fe0a:e14b on apcli0.*.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Registering new address record for 10.0.0.11 on apcli0.IPv4.
Mon Aug 24 15:54:01 2020 daemon.info avahi-daemon[849]: Registering HINFO record with values 'MIPS'/'LINUX'.
Mon Aug 24 15:54:03 2020 daemon.info avahi-daemon[849]: Server startup complete. Host name is hub5000-3.local. Local service cookie is 2607288958.
Mon Aug 24 15:54:04 2020 daemon.info avahi-daemon[849]: Service "PhidgetSBC (9c:65:f9:2a:e1:4b)" (/etc/avahi/services/phidgetsbc.service) successfully established.
Mon Aug 24 15:54:08 2020 kern.info ap_client: apcli0 is associated
Mon Aug 24 15:54:24 2020 kern.notice kernel: [   52.950000] random: nonblocking pool is initialized
Mon Aug 24 17:22:05 2020 kern.info kernel: [ 5314.640000] rt305x-esw 10110000.esw: link changed to 0x01
Mon Aug 24 17:22:06 2020 user.notice swplugd: Cable detected - bringing lan UP
Mon Aug 24 17:22:06 2020 daemon.notice netifd: Interface 'lan' is enabled
Mon Aug 24 17:22:06 2020 daemon.notice netifd: Interface 'lan' is setting up now
Mon Aug 24 17:22:06 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.30.4.
Mon Aug 24 17:22:06 2020 daemon.info avahi-daemon[849]: New relevant interface eth0.IPv4 for mDNS.
Mon Aug 24 17:22:06 2020 daemon.info avahi-daemon[849]: Registering new address record for 169.254.30.4 on eth0.IPv4.
Mon Aug 24 17:22:06 2020 daemon.notice netifd: Interface 'lan' is now up
Mon Aug 24 17:22:06 2020 daemon.notice netifd: Network device 'eth0' link is up
Mon Aug 24 17:22:06 2020 daemon.notice netifd: Interface 'lan' has link connectivity 
Mon Aug 24 17:22:06 2020 user.notice firewall: Reloading firewall due to ifup of lan (eth0)
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[1152]: exiting on receipt of SIGTERM
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[27131]: started, version 2.79rc1 cachesize 150
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[27131]: DNS service limited to local subnets
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[27131]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC no-ID loop-detect inotify
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq-dhcp[27131]: DHCP, IP range 192.168.100.100 -- 192.168.100.249, lease time 12h
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[27131]: using local addresses only for domain lan
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[27131]: reading /tmp/resolv.conf.auto
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[27131]: using local addresses only for domain lan
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[27131]: using nameserver 10.0.0.1#53
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[27131]: read /etc/hosts - 1 addresses
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[27131]: read /tmp/hosts/dhcp - 1 addresses
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq[27131]: read /tmp/hosts/odhcpd - 0 addresses
Mon Aug 24 17:22:07 2020 daemon.info dnsmasq-dhcp[27131]: read /etc/ethers - 0 addresses
Mon Aug 24 17:22:07 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::9e65:f9ff:fe2a:e14b.
Mon Aug 24 17:22:07 2020 daemon.info avahi-daemon[849]: New relevant interface eth0.IPv6 for mDNS.
Mon Aug 24 17:22:07 2020 daemon.info avahi-daemon[849]: Registering new address record for fe80::9e65:f9ff:fe2a:e14b on eth0.*.
Mon Aug 24 17:22:07 2020 daemon.info avahi-daemon[849]: Leaving mDNS multicast group on interface eth0.IPv6 with address fe80::9e65:f9ff:fe2a:e14b.
Mon Aug 24 17:22:07 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface eth0.IPv6 with address fd84:958e:53f::1.
Mon Aug 24 17:22:07 2020 daemon.info avahi-daemon[849]: Registering new address record for fd84:958e:53f::1 on eth0.*.
Mon Aug 24 17:22:07 2020 daemon.info avahi-daemon[849]: Withdrawing address record for fe80::9e65:f9ff:fe2a:e14b on eth0.
Mon Aug 24 17:22:07 2020 daemon.info avahi-daemon[849]: Joining mDNS multicast group on interface eth0.1.IPv6 with address fe80::9e65:f9ff:fe2a:e14b.
Mon Aug 24 17:22:07 2020 daemon.info avahi-daemon[849]: New relevant interface eth0.1.IPv6 for mDNS.
Mon Aug 24 17:22:07 2020 daemon.info avahi-daemon[849]: Registering new address record for fe80::9e65:f9ff:fe2a:e14b on eth0.1.*.

Re: Zeroconf_lookup() failed

Posted: Tue Sep 01, 2020 6:04 am
by luneart
I have tried few thing and arrived to different conclusions. I'm reporting them here for insights.
-First I tried to remove the phidget libraries, and to reinstall them (to the latest update of august), but no change.
-I have other HUB5000s and other units of the phidgets connected to the hub. So I connected 3 "sets":
* set1: HUB5000 (used to work) + SAF + DCC
* set2: HUB5000 (out of the box, firmware updated) + SAF + DCC
* set3: HUB5000 (out of the box, firmware updated) + SAF + DCC
The 2nd HUB5000 is dectected and the phidgets connected work. The others do not (either not mentioned in the log or "zeroconf lookup failed").
-I have moved all sets well apart from each other thinking electrical interference - same result (but set2 was closed to the wireless repeater that the all hubs connect to)
-I swapped every single unit (including hub) in that second set with that of other sets, but the 2nd set always worked while the others don't.
-I have moved the set1 next to the wireless repeater that the all hubs connect to - now only set1 works.

```phidget22admin -l -s -R``` gives me various results, usually only the hub in the set1 (previously, set2), sometimes all 3.
the results:

Code: Select all

$ phidget22admin -l -s -R
Phidget22 Server   hub5000                        hub5000:5661             10.0.0.11     
Phidget22 Web Server listener hub5000 Phidget22 WWW Server   hub5000 Phidget22 WWW Server:8080 10.0.0.11     
$ phidget22admin -l -s -R
Phidget22 Server   hub5000                        hub5000:5661             10.0.0.11     
Phidget SBC        PhidgetSBC (9c:65:f9:2a:e1:95) PhidgetSBC (9c:65:f9:2a:e1:95):80 10.0.0.14     
$ phidget22admin -l -s -R
Phidget22 Server   hub5000                        hub5000:5661             10.0.0.11     
Phidget22 Web Server listener hub5000 Phidget22 WWW Server   hub5000 Phidget22 WWW Server:8080 10.0.0.11     
$ phidget22admin -l -s -R
Phidget22 Server   hub5000                        hub5000:5661             10.0.0.11     
Phidget22 Web Server listener hub5000 Phidget22 WWW Server   hub5000 Phidget22 WWW Server:8080 10.0.0.11     
$ phidget22admin -l -s -R
Phidget22 Server   hub5000                        hub5000:5661             10.0.0.11     
Phidget22 Web Server listener hub5000 Phidget22 WWW Server   hub5000 Phidget22 WWW Server:8080 10.0.0.11     
the log:

Code: Select all

2020-09-01T13:59:29 <ERROR> phidget22 : 
	******************************  Logging Enabled  ******************************
	* Phidget22 - Version 1.6 - Built Aug 31 2020 13:42:13                        *
	*******************************************************************************
2020-09-01T13:59:29 <ERROR> phidget22net[sbcServerListener()] : Zeroconf_lookup() failed for PhidgetSBC (9c:65:f9:2a:e1:4b) [PhidgetSBC (9c:65:f9:2a:e1:4b)]
2020-09-01T13:59:34 <ERROR> phidget22 : 
	******************************  Logging Enabled  ******************************
	* Phidget22 - Version 1.6 - Built Aug 31 2020 13:42:13                        *
	*******************************************************************************
2020-09-01T13:59:34 <ERROR> phidget22net[wwwServerListener()] : Zeroconf_lookup() failed for hub5000 Phidget22 WWW Server
2020-09-01T13:59:34 <ERROR> phidget22net[sbcServerListener()] : Zeroconf_lookup() failed for PhidgetSBC (9c:65:f9:2a:e1:95) [PhidgetSBC (9c:65:f9:2a:e1:95)]
2020-09-01T13:59:40 <ERROR> phidget22 : 
	******************************  Logging Enabled  ******************************
	* Phidget22 - Version 1.6 - Built Aug 31 2020 13:42:13                        *
	*******************************************************************************
2020-09-01T13:59:51 <ERROR> phidget22 : 
	******************************  Logging Enabled  ******************************
	* Phidget22 - Version 1.6 - Built Aug 31 2020 13:42:13                        *
	*******************************************************************************
2020-09-01T14:00:00 <ERROR> phidget22 : 
	******************************  Logging Enabled  ******************************
	* Phidget22 - Version 1.6 - Built Aug 31 2020 13:42:13                        *
	*******************************************************************************
2020-09-01T14:00:00 <ERROR> phidget22net[sbcServerListener()] : Zeroconf_lookup() failed for PhidgetSBC (9c:65:f9:2a:e1:4b) [PhidgetSBC (9c:65:f9:2a:e1:4b)]
2020-09-01T14:00:00 <ERROR> phidget22net[sbcServerListener()] : Zeroconf_lookup() failed for PhidgetSBC (9c:65:f9:2a:e1:95) [PhidgetSBC (9c:65:f9:2a:e1:95)]

Re: Zeroconf_lookup() failed

Posted: Tue Sep 01, 2020 12:10 pm
by luneart
kinda solved - enough for me: the networking API has the PhidgetNet_addServer that allows me to manually enter the addresses of all hubs and bypass the zeroconf_lookup.
Conclusion: it was not a hardware or EMF problem....