Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

adapter quits with timeout #31

Closed
epcos71 opened this issue Oct 27, 2020 · 20 comments
Closed

adapter quits with timeout #31

epcos71 opened this issue Oct 27, 2020 · 20 comments

Comments

@epcos71
Copy link

epcos71 commented Oct 27, 2020 •
edited
Loading

Hi,

I have a problem with the start of the adapter. Everything worked well before, but now the adapter quits with a timeout:

_> fb-checkpresence.0 | 2020-10-27 15:20:30.902 | info | (20132) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason

-- | -- | -- | --
fb-checkpresence.0 | 2020-10-27 15:20:30.902 | info | (20132) terminating
fb-checkpresence.0 | 2020-10-27 15:20:30.902 | info | (20132) cleaned everything up...
fb-checkpresence.0 | 2020-10-27 15:20:30.901 | info | (20132) Got terminate signal TERMINATE_YOURSELF
fb-checkpresence.0 | 2020-10-27 15:20:30.869 | error | (20132) createFbDeviceObjects -> can't read devices from fritzbox!
fb-checkpresence.0 | 2020-10-27 15:20:30.868 | error | (20132) soapAction X_AVM-DE_GetHostListPath status=ETIMEDOUT errNo=5 connect ETIMEDOUT 192.168.2.1:49443
fb-checkpresence.0 | 2020-10-27 15:20:09.655 | info | (20132) service GetInfo is supported
fb-checkpresence.0 | 2020-10-27 15:20:09.619 | info | (20132) service GetSecurityPort is supported
fb-checkpresence.0 | 2020-10-27 15:20:09.591 | info | (20132) service X_AVM-DE_GetSpecificHostEntryByIP is supported
fb-checkpresence.0 | 2020-10-27 15:20:09.565 | info | (20132) service GetSpecificHostEntry is supported
fb-checkpresence.0 | 2020-10-27 15:20:09.534 | info | (20132) service X_AVM-DE_GetHostListPath is supported
fb-checkpresence.0 | 2020-10-27 15:20:09.489 | info | (20132) start fb-checkpresence: ip-address: 192.168.2.1 polling interval: 1 Min.
fb-checkpresence.0 | 2020-10-27 15:20:09.461 | info | (20132) starting. Version 1.0.4 in C:/iobroker/node_modules/iobroker.fb-checkpresence, node: v12.16.2, js-controller: 3.1.6_

The problem occurs on two of my installations with windows10 2004 home edition.
Additional Fritzbox user is created with password (access for all applications is also set within FB7590 with Fritz!OS 7.2.1)

My configuration:

  • TR-064 adapter V4.1.0 (is configured and works well)
  • fb-checkpresence V1.0.4
  • iobroker v4.1.10
  • JS controller 3.1.6

Thanks in advance!
@afuerhoff
Copy link
Owner

Please reboot the fritzbox and check it again. In some cases the fritzbox tr-064 service hangs up and the fritzbox needs a reboot.

@epcos71
Copy link
Author

epcos71 commented Oct 27, 2020

Done multiple times ... no change

@afuerhoff
Copy link
Owner

Can you post a log with Loglevel debug.

@epcos71
Copy link
Author

epcos71 commented Oct 28, 2020

Hi and thanks. Here it is...

fb-checkpresence.0 2020-10-28 06:44:28.110 info (7008) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
fb-checkpresence.0 2020-10-28 06:44:28.110 info (7008) terminating
fb-checkpresence.0 2020-10-28 06:44:28.109 info (7008) cleaned everything up...
fb-checkpresence.0 2020-10-28 06:44:28.109 info (7008) Got terminate signal TERMINATE_YOURSELF
fb-checkpresence.0 2020-10-28 06:44:28.083 error (7008) createFbDeviceObjects -> can't read devices from fritzbox!
fb-checkpresence.0 2020-10-28 06:44:28.083 error (7008) soapAction X_AVM-DE_GetHostListPath status=ETIMEDOUT errNo=5 connect ETIMEDOUT 192.168.2.1:49443
fb-checkpresence.0 2020-10-28 06:44:07.041 debug (7008) chCount 0
fb-checkpresence.0 2020-10-28 06:44:07.040 debug (7008) response: 0 "\n <s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/\" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/\">\n<s:Header>\n<h:Challeng
fb-checkpresence.0 2020-10-28 06:44:07.014 debug (7008) function fb-devices true
fb-checkpresence.0 2020-10-28 06:44:07.014 debug (7008) createGlobalObjects
fb-checkpresence.0 2020-10-28 06:44:07.011 debug (7008) sslPort 49443
fb-checkpresence.0 2020-10-28 06:44:07.007 debug (7008) response: 0 "\n <s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/\" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/\">\n<s:Body>\n<u:GetSecurit
fb-checkpresence.0 2020-10-28 06:44:06.251 info (7008) service GetInfo is supported
fb-checkpresence.0 2020-10-28 06:44:06.222 info (7008) service GetSecurityPort is supported
fb-checkpresence.0 2020-10-28 06:44:06.199 info (7008) service X_AVM-DE_GetSpecificHostEntryByIP is supported
fb-checkpresence.0 2020-10-28 06:44:06.171 info (7008) service GetSpecificHostEntry is supported
fb-checkpresence.0 2020-10-28 06:44:06.144 info (7008) service X_AVM-DE_GetHostListPath is supported
fb-checkpresence.0 2020-10-28 06:44:06.101 debug (7008) configuration familymembers: []
fb-checkpresence.0 2020-10-28 06:44:06.100 debug (7008) configuration dateformat: <yyyy.mm.dd HH:MM:ss>
fb-checkpresence.0 2020-10-28 06:44:06.100 debug (7008) configuration history: <influxdb.0>
fb-checkpresence.0 2020-10-28 06:44:06.100 debug (7008) configuration user:
fb-checkpresence.0 2020-10-28 06:44:06.100 info (7008) start fb-checkpresence: ip-address: 192.168.2.1 polling interval: 1 Min.
fb-checkpresence.0 2020-10-28 06:44:06.081 info (7008) starting. Version 1.0.4 in C:/iobroker/node_modules/iobroker.fb-checkpresence, node: v12.16.2, js-controller: 3.1.6
fb-checkpresence.0 2020-10-28 06:44:05.991 debug (7008) statesDB connected
fb-checkpresence.0 2020-10-28 06:44:05.991 debug (7008) States connected to redis: 127.0.0.1:9000
fb-checkpresence.0 2020-10-28 06:44:05.985 debug (7008) States create System PubSub Client
fb-checkpresence.0 2020-10-28 06:44:05.983 debug (7008) States create User PubSub Client
fb-checkpresence.0 2020-10-28 06:44:05.979 debug (7008) Redis States: Use Redis connection: 127.0.0.1:9000
fb-checkpresence.0 2020-10-28 06:44:05.978 debug (7008) objectDB connected
fb-checkpresence.0 2020-10-28 06:44:05.976 debug (7008) Objects connected to redis: 127.0.0.1:9001
fb-checkpresence.0 2020-10-28 06:44:05.968 debug (7008) Objects client initialize lua scripts
fb-checkpresence.0 2020-10-28 06:44:05.968 debug (7008) Objects create User PubSub Client
fb-checkpresence.0 2020-10-28 06:44:05.967 debug (7008) Objects create System PubSub Client
fb-checkpresence.0 2020-10-28 06:44:05.966 debug (7008) Objects client ready ... initialize now
fb-checkpresence.0 2020-10-28 06:44:05.953 debug (7008) Redis Objects: Use Redis connection: 127.0.0.1:9001
fb-checkpresence.0 2020-10-28 06:41:28.289 info (16932) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
fb-checkpresence.0 2020-10-28 06:41:28.288 info (16932) terminating
fb-checkpresence.0 2020-10-28 06:41:28.288 info (16932) cleaned everything up...
fb-checkpresence.0 2020-10-28 06:41:28.287 info (16932) Got terminate signal TERMINATE_YOURSELF
fb-checkpresence.0 2020-10-28 06:41:28.265 error (16932) createFbDeviceObjects -> can't read devices from fritzbox!
fb-checkpresence.0 2020-10-28 06:41:28.264 error (16932) soapAction X_AVM-DE_GetHostListPath status=ETIMEDOUT errNo=5 connect ETIMEDOUT 192.168.2.1:49443
fb-checkpresence.0 2020-10-28 06:41:07.115 info (16932) service GetInfo is supported
fb-checkpresence.0 2020-10-28 06:41:07.090 info (16932) service GetSecurityPort is supported
fb-checkpresence.0 2020-10-28 06:41:07.070 info (16932) service X_AVM-DE_GetSpecificHostEntryByIP is supported
fb-checkpresence.0 2020-10-28 06:41:07.051 info (16932) service GetSpecificHostEntry is supported
fb-checkpresence.0 2020-10-28 06:41:07.032 info (16932) service X_AVM-DE_GetHostListPath is supported
fb-checkpresence.0 2020-10-28 06:41:06.995 info (16932) start fb-checkpresence: ip-address: 192.168.2.1 polling interval: 1 Min.
fb-checkpresence.0 2020-10-28 06:41:06.979 info (16932) starting. Version 1.0.4 in C:/iobroker/node_modules/iobroker.fb-checkpresence, node: v12.16.2, js-controller: 3.1.6

@afuerhoff
Copy link
Owner

Has you configured a user and family members?

@epcos71
Copy link
Author

epcos71 commented Oct 28, 2020

Hi,
I created also a new user in my FB with all needed privileges, and I also deleted all family members and created a new one.
Result is the same, I get a time out. Here is the corresponding log file:

fb-checkpresence.0 2020-10-28 10:43:59.288 debug (6080) enableHistory.2 iPhone11-von-Michael true
fb-checkpresence.0 2020-10-28 10:43:59.253 debug (6080) sendTo "enableHistory" to system.adapter.influxdb.0 from system.adapter.fb-checkpresence.0
fb-checkpresence.0 2020-10-28 10:43:59.241 info (6080) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
fb-checkpresence.0 2020-10-28 10:43:59.240 info (6080) terminating
fb-checkpresence.0 2020-10-28 10:43:59.240 info (6080) cleaned everything up...
fb-checkpresence.0 2020-10-28 10:43:59.239 info (6080) Got terminate signal TERMINATE_YOURSELF
fb-checkpresence.0 2020-10-28 10:43:59.224 debug (6080) sendTo "getEnabledDPs" to system.adapter.influxdb.0 from system.adapter.fb-checkpresence.0
fb-checkpresence.0 2020-10-28 10:43:59.223 debug (6080) createMemberObjects iPhone11-von-Michael
fb-checkpresence.0 2020-10-28 10:43:59.205 error (6080) createFbDeviceObjects -> can't read devices from fritzbox!
fb-checkpresence.0 2020-10-28 10:43:59.205 error (6080) soapAction X_AVM-DE_GetHostListPath status=ETIMEDOUT errNo=5 connect ETIMEDOUT 192.168.2.1:49443
fb-checkpresence.0 2020-10-28 10:43:38.121 debug (6080) chCount 0
fb-checkpresence.0 2020-10-28 10:43:38.119 debug (6080) response: 0 "\n <s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/\" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/\">\n<s:Header>\n<h:Challeng
fb-checkpresence.0 2020-10-28 10:43:38.067 debug (6080) function fb-devices true
fb-checkpresence.0 2020-10-28 10:43:38.067 debug (6080) createGlobalObjects
fb-checkpresence.0 2020-10-28 10:43:38.064 debug (6080) sslPort 49443
fb-checkpresence.0 2020-10-28 10:43:38.058 debug (6080) response: 0 "\n <s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/\" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/\">\n<s:Body>\n<u:GetSecurit
fb-checkpresence.0 2020-10-28 10:43:38.016 info (6080) service GetInfo is supported
fb-checkpresence.0 2020-10-28 10:43:37.967 info (6080) service GetSecurityPort is supported
fb-checkpresence.0 2020-10-28 10:43:37.903 info (6080) service X_AVM-DE_GetSpecificHostEntryByIP is supported
fb-checkpresence.0 2020-10-28 10:43:37.884 info (6080) service GetSpecificHostEntry is supported
fb-checkpresence.0 2020-10-28 10:43:37.863 info (6080) service X_AVM-DE_GetHostListPath is supported
fb-checkpresence.0 2020-10-28 10:43:37.764 debug (6080) configuration familymembers: [{"familymember":"iPhone11-von-Michael","macaddress":"F4:DB:E3:BB:C4:1F","ipaddress":"192.168.2.95","useip":true,"comment":"","enabled":true}]
fb-checkpresence.0 2020-10-28 10:43:37.763 debug (6080) configuration dateformat: <yyyy.mm.dd HH:MM:ss>
fb-checkpresence.0 2020-10-28 10:43:37.763 debug (6080) configuration history: <influxdb.0>
fb-checkpresence.0 2020-10-28 10:43:37.763 debug (6080) configuration user:
fb-checkpresence.0 2020-10-28 10:43:37.763 info (6080) start fb-checkpresence: ip-address: 192.168.2.1 polling interval: 1 Min.
fb-checkpresence.0 2020-10-28 10:43:37.746 info (6080) starting. Version 1.0.4 in C:/iobroker/node_modules/iobroker.fb-checkpresence, node: v12.16.2, js-controller: 3.1.6
fb-checkpresence.0 2020-10-28 10:43:37.630 debug (6080) statesDB connected
fb-checkpresence.0 2020-10-28 10:43:37.629 debug (6080) States connected to redis: 127.0.0.1:9000
fb-checkpresence.0 2020-10-28 10:43:37.620 debug (6080) States create System PubSub Client
fb-checkpresence.0 2020-10-28 10:43:37.619 debug (6080) States create User PubSub Client
fb-checkpresence.0 2020-10-28 10:43:37.614 debug (6080) Redis States: Use Redis connection: 127.0.0.1:9000
fb-checkpresence.0 2020-10-28 10:43:37.613 debug (6080) objectDB connected
fb-checkpresence.0 2020-10-28 10:43:37.610 debug (6080) Objects connected to redis: 127.0.0.1:9001
fb-checkpresence.0 2020-10-28 10:43:37.600 debug (6080) Objects client initialize lua scripts
fb-checkpresence.0 2020-10-28 10:43:37.600 debug (6080) Objects create User PubSub Client
fb-checkpresence.0 2020-10-28 10:43:37.599 debug (6080) Objects create System PubSub Client
fb-checkpresence.0 2020-10-28 10:43:37.590 debug (6080) Objects client ready ... initialize now
fb-checkpresence.0 2020-10-28 10:43:37.576 debug (6080) Redis Objects: Use Redis connection: 127.0.0.1:9001

@afuerhoff
Copy link
Owner

The question is, if you have a user configured in the adapter configuration dialog. In the log I see no user.

@epcos71
Copy link
Author

epcos71 commented Oct 28, 2020

Configuration user was set, also password. But you are right, in the log it was not visible, because the "<" are interpreted as formatting comments. So I removed them in the log. But believe me, user name and password are set :)

fb-checkpresence.0 | 2020-10-28 19:47:04.378 | info | (4156) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
fb-checkpresence.0 | 2020-10-28 19:47:04.378 | info | (4156) terminating
fb-checkpresence.0 | 2020-10-28 19:47:04.377 | info | (4156) cleaned everything up...
fb-checkpresence.0 | 2020-10-28 19:47:04.376 | info | (4156) Got terminate signal TERMINATE_YOURSELF
fb-checkpresence.0 | 2020-10-28 19:47:02.711 | debug | (4156) chCount 0
fb-checkpresence.0 | 2020-10-28 19:47:02.709 | debug | (4156) response: 0 "\n <s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/\" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/\">\n<s:Header>\n<h:Challeng
fb-checkpresence.0 | 2020-10-28 19:47:02.684 | debug | (4156) function fb-devices true
fb-checkpresence.0 | 2020-10-28 19:47:02.684 | debug | (4156) createGlobalObjects
fb-checkpresence.0 | 2020-10-28 19:47:02.681 | debug | (4156) sslPort 49443
fb-checkpresence.0 | 2020-10-28 19:47:02.675 | debug | (4156) response: 0 "\n <s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/\" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/\">\n<s:Body>\n<u:GetSecurit
fb-checkpresence.0 | 2020-10-28 19:47:02.610 | info | (4156) service GetInfo is supported
fb-checkpresence.0 | 2020-10-28 19:47:02.586 | info | (4156) service GetSecurityPort is supported
fb-checkpresence.0 | 2020-10-28 19:47:02.563 | info | (4156) service X_AVM-DE_GetSpecificHostEntryByIP is supported
fb-checkpresence.0 | 2020-10-28 19:47:02.539 | info | (4156) service GetSpecificHostEntry is supported
fb-checkpresence.0 | 2020-10-28 19:47:02.509 | info | (4156) service X_AVM-DE_GetHostListPath is supported
fb-checkpresence.0 | 2020-10-28 19:47:02.479 | debug | (4156) configuration familymembers: [{"familymember":"iPhone11-von-Michael","macaddress":"F4:DB:E3:BB:C4:1F","ipaddress":"192.168.2.95","useip":true,"comment":"","enabled":true}]
fb-checkpresence.0 | 2020-10-28 19:47:02.479 | debug | (4156) configuration dateformat: <yyyy.mm.dd HH:MM:ss>
fb-checkpresence.0 | 2020-10-28 19:47:02.479 | debug | (4156) configuration history: influxdb.0
fb-checkpresence.0 | 2020-10-28 19:47:02.478 | debug | (4156) configuration user: iobroker
fb-checkpresence.0 | 2020-10-28 19:47:02.478 | info | (4156) start fb-checkpresence: ip-address: 192.168.2.1 polling interval: 1 Min.
fb-checkpresence.0 | 2020-10-28 19:47:02.459 | info | (4156) starting. Version 1.0.4 in C:/iobroker/node_modules/iobroker.fb-checkpresence, node: v12.16.2, js-controller: 3.1.6
fb-checkpresence.0 | 2020-10-28 19:47:02.358 | debug | (4156) statesDB connected
fb-checkpresence.0 | 2020-10-28 19:47:02.357 | debug | (4156) States connected to redis: 127.0.0.1:9000
fb-checkpresence.0 | 2020-10-28 19:47:02.350 | debug | (4156) States create System PubSub Client
fb-checkpresence.0 | 2020-10-28 19:47:02.348 | debug | (4156) States create User PubSub Client
fb-checkpresence.0 | 2020-10-28 19:47:02.343 | debug | (4156) Redis States: Use Redis connection: 127.0.0.1:9000
fb-checkpresence.0 | 2020-10-28 19:47:02.343 | debug | (4156) objectDB connected
fb-checkpresence.0 | 2020-10-28 19:47:02.340 | debug | (4156) Objects connected to redis: 127.0.0.1:9001
fb-checkpresence.0 | 2020-10-28 19:47:02.330 | debug | (4156) Objects client initialize lua scripts
fb-checkpresence.0 | 2020-10-28 19:47:02.329 | debug | (4156) Objects create User PubSub Client
fb-checkpresence.0 | 2020-10-28 19:47:02.329 | debug | (4156) Objects create System PubSub Client
fb-checkpresence.0 | 2020-10-28 19:47:02.327 | debug | (4156) Objects client ready ... initialize now
fb-checkpresence.0 | 2020-10-28 19:47:02.313 | debug | (4156) Redis Objects: Use Redis connection: 127.0.0.1:9001

@afuerhoff
Copy link
Owner

Hello, I can't recreate the problem, but I've published a new version on Github.
Please test this and see if the error has been resolved.
https://forum.iobroker.net/topic/37959/test-adapter-fb-checkpresence-v1-1-x

@epcos71
Copy link
Author

epcos71 commented Oct 28, 2020

Hi, erst mal ein großes Danke für die super Hilfe!!!
Ich habe jetzt die Version 1.1.0 installiert, funktioniert aber leider immer noch nicht.

fb-checkpresence.0 | 2020-10-28 21:43:39.402 | info | (8072) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
fb-checkpresence.0 | 2020-10-28 21:43:39.401 | info | (8072) terminating
fb-checkpresence.0 | 2020-10-28 21:43:39.401 | info | (8072) cleaned everything up ...
fb-checkpresence.0 | 2020-10-28 21:43:39.400 | info | (8072) Got terminate signal TERMINATE_YOURSELF
fb-checkpresence.0 | 2020-10-28 21:43:39.357 | error | (8072) createFbDeviceObjects -> can't read devices from fritzbox! Adapter stops
fb-checkpresence.0 | 2020-10-28 21:43:39.356 | error | (8072) getDeviceList: "Can not read hostlist path"
fb-checkpresence.0 | 2020-10-28 21:43:39.356 | error | (8072) soapAction /upnp/control/hosts X_AVM-DE_GetHostListPath status=ETIMEDOUT errNo=5 connect ETIMEDOUT 192.168.2.1:49443
fb-checkpresence.0 | 2020-10-28 21:43:18.273 | info | (8072) createMemberObjects finished successfully
fb-checkpresence.0 | 2020-10-28 21:43:18.273 | debug | (8072) enableHistory.2 iPhone11-von-Michael true
fb-checkpresence.0 | 2020-10-28 21:43:18.255 | debug | (8072) sendTo "enableHistory" to system.adapter.influxdb.0 from system.adapter.fb-checkpresence.0
fb-checkpresence.0 | 2020-10-28 21:43:18.243 | debug | (8072) sendTo "getEnabledDPs" to system.adapter.influxdb.0 from system.adapter.fb-checkpresence.0
fb-checkpresence.0 | 2020-10-28 21:43:18.219 | info | (8072) createGlobalObjects finished successfully
fb-checkpresence.0 | 2020-10-28 21:43:18.120 | info | (8072) service DeviceConfig1-Reboot is supported
fb-checkpresence.0 | 2020-10-28 21:43:18.106 | info | (8072) service X_AVM-DE_HostFilter-GetWANAccessByIP is supported
fb-checkpresence.0 | 2020-10-28 21:43:18.088 | info | (8072) service X_AVM-DE_HostFilter-DisallowWANAccessByIP is supported
fb-checkpresence.0 | 2020-10-28 21:43:18.069 | info | (8072) service DeviceInfo1-GetInfo is supported
fb-checkpresence.0 | 2020-10-28 21:43:18.049 | info | (8072) service WLANConfiguration3-GetInfo is supported
fb-checkpresence.0 | 2020-10-28 21:43:18.011 | info | (8072) service WLANConfiguration3-SetEnable is supported
fb-checkpresence.0 | 2020-10-28 21:43:17.978 | info | (8072) service WANPPPConnection1-GetInfo is supported
fb-checkpresence.0 | 2020-10-28 21:43:17.949 | info | (8072) service DeviceInfo1-GetSecurityPort is supported
fb-checkpresence.0 | 2020-10-28 21:43:17.929 | info | (8072) service Hosts1-X_AVM-DE_GetSpecificHostEntryByIP is supported
fb-checkpresence.0 | 2020-10-28 21:43:17.911 | info | (8072) service Hosts1-GetSpecificHostEntry is supported
fb-checkpresence.0 | 2020-10-28 21:43:17.889 | info | (8072) service Hosts1-X_AVM-DE_GetMeshListPath is supported
fb-checkpresence.0 | 2020-10-28 21:43:17.842 | info | (8072) service Hosts1-X_AVM-DE_GetHostListPath is supported
fb-checkpresence.0 | 2020-10-28 21:43:17.817 | debug | (8072) ssl-port {"status":200,"result":true,"resultData":{"$":{"xmlns:u":"urn:dslforum-org:service:DeviceInfo:1"},"NewSecurityPort":"49443"},"errNo":0,"errorMsg":""}
fb-checkpresence.0 | 2020-10-28 21:43:17.735 | debug | (8072) services loaded successfully{"root":{"$":{"xmlns":"urn:dslforum-org:device-1-0"},"specVersion":{"major":"1","minor":"0"},"systemVersion":{"HW":"226","Major":"154","Minor":"7","Patch":"21","Bui
fb-checkpresence.0 | 2020-10-28 21:43:17.675 | debug | (8072) configuratuion mesh info: false
fb-checkpresence.0 | 2020-10-28 21:43:17.675 | debug | (8072) configuration fb-devices true
fb-checkpresence.0 | 2020-10-28 21:43:17.675 | debug | (8072) configuration familymembers: [{"familymember":"iPhone11-von-Michael","macaddress":"F4:DB:E3:BB:C4:1F","ipaddress":"192.168.2.95","useip":true,"comment":"","enabled":true}]
fb-checkpresence.0 | 2020-10-28 21:43:17.674 | debug | (8072) configuration dateformat: <yyyy.mm.dd HH:MM:ss>
fb-checkpresence.0 | 2020-10-28 21:43:17.674 | debug | (8072) configuration history: <influxdb.0>
fb-checkpresence.0 | 2020-10-28 21:43:17.674 | debug | (8072) configuration user:
fb-checkpresence.0 | 2020-10-28 21:43:17.674 | info | (8072) start fb-checkpresence: ip-address: "192.168.2.1" - interval devices: 1 Min. - interval members: 60 s
fb-checkpresence.0 | 2020-10-28 21:43:17.655 | info | (8072) starting. Version 1.1.0 in C:/iobroker/node_modules/iobroker.fb-checkpresence, node: v12.16.2, js-controller: 3.1.6
fb-checkpresence.0 | 2020-10-28 21:43:17.551 | debug | (8072) statesDB connected
fb-checkpresence.0 | 2020-10-28 21:43:17.551 | debug | (8072) States connected to redis: 127.0.0.1:9000
fb-checkpresence.0 | 2020-10-28 21:43:17.544 | debug | (8072) States create System PubSub Client
fb-checkpresence.0 | 2020-10-28 21:43:17.543 | debug | (8072) States create User PubSub Client
fb-checkpresence.0 | 2020-10-28 21:43:17.538 | debug | (8072) Redis States: Use Redis connection: 127.0.0.1:9000
fb-checkpresence.0 | 2020-10-28 21:43:17.537 | debug | (8072) objectDB connected
fb-checkpresence.0 | 2020-10-28 21:43:17.535 | debug | (8072) Objects connected to redis: 127.0.0.1:9001
fb-checkpresence.0 | 2020-10-28 21:43:17.527 | debug | (8072) Objects client initialize lua scripts
fb-checkpresence.0 | 2020-10-28 21:43:17.526 | debug | (8072) Objects create User PubSub Client
fb-checkpresence.0 | 2020-10-28 21:43:17.526 | debug | (8072) Objects create System PubSub Client
fb-checkpresence.0 | 2020-10-28 21:43:17.525 | debug | (8072) Objects client ready ... initialize now
fb-checkpresence.0 | 2020-10-28 21:43:17.512 | debug | (8072) Redis Objects: Use Redis connection: 127.0.0.1:9001

@afuerhoff
Copy link
Owner

afuerhoff commented Oct 28, 2020 •
edited
Loading

Hallo, wenn bei mir der Fehler aufgetreten war, hat eigentlich immer ein Reboot geholfen. Vielleicht vorher den Adapter anhalten und nach dem Reboot neu starten. Das Timeout kommt von der Fritzbox. Die antwortet nicht. Was allerdings eigenartig ist, das der Security Port gelesen werden kann.

Kannst Du das Passwort einmal neu eingeben und speichern.

@epcos71
Copy link
Author

epcos71 commented Oct 30, 2020

Hi, alles schon versucht. Habe sogar einen neuen FB User mit den entsprechenden Rechten eingerichtet. Leider ohne Erfolg... Ich habe das Gefühl, dass die FB unter dem Port nicht erreichbar ist... Der TR-Adapter hingegen läuft problemlos...

@afuerhoff
Copy link
Owner

Kannst du mal die Fb-Devices in der Konfiguration abhaken. Dann müsste es wahrscheinlich funktionieren.
Löst zwar nicht das Problem, grenzt es aber auf eine spezielle Funktion ein.

@epcos71
Copy link
Author

epcos71 commented Oct 30, 2020

Hi, hab jetzt alles FB Devices deaktiviert, "FB-Geräte erstellen", sowie "Mesh Informationen erstellen" abgewählt... Der Adapter startet jetzt... ich versuche jetzt mal nach und nach wieder Option zuzuschalten...

Hier das Log (falls es hilft, auf jeden Fall erstmal Danke bis hierhin für Deine Hilfe!!!):

fb-checkpresence.0 | 2020-10-30 17:02:58.448 | debug | (4956) system.adapter.admin.0: logging true
fb-checkpresence.0 | 2020-10-30 17:02:57.690 | debug | (4956) system.adapter.admin.0: logging false
fb-checkpresence.0 | 2020-10-30 17:02:26.938 | debug | (4956) loopDevices ends after 0,409000 s
fb-checkpresence.0 | 2020-10-30 17:02:26.938 | debug | (4956) loopDevices starts
fb-checkpresence.0 | 2020-10-30 17:02:11.794 | debug | (4956) loopFamily ends after 0,539202200 s
fb-checkpresence.0 | 2020-10-30 17:01:25.873 | debug | (4956) loopDevices ends after 0,404300 s
fb-checkpresence.0 | 2020-10-30 17:01:25.872 | debug | (4956) loopDevices starts
fb-checkpresence.0 | 2020-10-30 17:01:20.836 | info | (4956) createGlobalObjects finished successfully
fb-checkpresence.0 | 2020-10-30 17:01:20.778 | info | (4956) service DeviceConfig1-Reboot is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.751 | info | (4956) service X_AVM-DE_HostFilter-GetWANAccessByIP is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.722 | info | (4956) service X_AVM-DE_HostFilter-DisallowWANAccessByIP is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.686 | info | (4956) service DeviceInfo1-GetInfo is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.664 | info | (4956) service WLANConfiguration3-GetInfo is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.622 | info | (4956) service WLANConfiguration3-SetEnable is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.583 | info | (4956) service WANPPPConnection1-GetInfo is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.558 | info | (4956) service DeviceInfo1-GetSecurityPort is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.531 | info | (4956) service Hosts1-X_AVM-DE_GetSpecificHostEntryByIP is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.505 | info | (4956) service Hosts1-GetSpecificHostEntry is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.479 | info | (4956) service Hosts1-X_AVM-DE_GetMeshListPath is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.444 | info | (4956) service Hosts1-X_AVM-DE_GetHostListPath is supported
fb-checkpresence.0 | 2020-10-30 17:01:20.413 | debug | (4956) ssl-port {"status":200,"result":true,"resultData":{"$":{"xmlns:u":"urn:dslforum-org:service:DeviceInfo:1"},"NewSecurityPort":"49443"},"errNo":0,"errorMsg":""}
fb-checkpresence.0 | 2020-10-30 17:01:20.069 | debug | (4956) services loaded successfully{"root":{"$":{"xmlns":"urn:dslforum-org:device-1-0"},"specVersion":{"major":"1","minor":"0"},"systemVersion":{"HW":"226","Major":"154","Minor":"7","Patch":"21","Bui
fb-checkpresence.0 | 2020-10-30 17:01:19.924 | debug | (4956) configuratuion mesh info: false
fb-checkpresence.0 | 2020-10-30 17:01:19.924 | debug | (4956) configuration fb-devices false
fb-checkpresence.0 | 2020-10-30 17:01:19.924 | debug | (4956) configuration familymembers: [{"familymember":"iPhone11-von-Michael","macaddress":"F4:DB:E3:BB:C4:1F","ipaddress":"192.168.2.95","useip":false,"comment":"","enabled":false}]
fb-checkpresence.0 | 2020-10-30 17:01:19.924 | debug | (4956) configuration dateformat: <yyyy.mm.dd HH:MM:ss>
fb-checkpresence.0 | 2020-10-30 17:01:19.924 | debug | (4956) configuration history: <influxdb.0>
fb-checkpresence.0 | 2020-10-30 17:01:19.924 | debug | (4956) configuration user:
fb-checkpresence.0 | 2020-10-30 17:01:19.924 | info | (4956) start fb-checkpresence: ip-address: "fritz.box" - interval devices: 1 Min. - interval members: 60 s
fb-checkpresence.0 | 2020-10-30 17:01:19.914 | info | (4956) starting. Version 1.1.0 in C:/iobroker/node_modules/iobroker.fb-checkpresence, node: v12.16.2, js-controller: 3.1.6
fb-checkpresence.0 | 2020-10-30 17:01:19.814 | debug | (4956) statesDB connected
fb-checkpresence.0 | 2020-10-30 17:01:19.813 | debug | (4956) States connected to redis: 127.0.0.1:9000
fb-checkpresence.0 | 2020-10-30 17:01:19.807 | debug | (4956) States create System PubSub Client
fb-checkpresence.0 | 2020-10-30 17:01:19.806 | debug | (4956) States create User PubSub Client
fb-checkpresence.0 | 2020-10-30 17:01:19.801 | debug | (4956) Redis States: Use Redis connection: 127.0.0.1:9000
fb-checkpresence.0 | 2020-10-30 17:01:19.800 | debug | (4956) objectDB connected
fb-checkpresence.0 | 2020-10-30 17:01:19.798 | debug | (4956) Objects connected to redis: 127.0.0.1:9001
fb-checkpresence.0 | 2020-10-30 17:01:19.790 | debug | (4956) Objects client initialize lua scripts
fb-checkpresence.0 | 2020-10-30 17:01:19.790 | debug | (4956) Objects create User PubSub Client
fb-checkpresence.0 | 2020-10-30 17:01:19.789 | debug | (4956) Objects create System PubSub Client
fb-checkpresence.0 | 2020-10-30 17:01:19.788 | debug | (4956) Objects client ready ... initialize now
fb-checkpresence.0 | 2020-10-30 17:01:19.776 | debug | (4956) Redis Objects: Use Redis connection: 127.0.0.1:9001

@epcos71
Copy link
Author

epcos71 commented Oct 31, 2020

Hallo,
frage mich bitte nicht warum, aber der Adapter funktioniert jetzt einwandfrei!!
Vielen Dank für die Unterstützung !!!

Grüße!

@epcos71 epcos71 closed this as completed Oct 31, 2020
@afuerhoff
Copy link
Owner

Schön das es jetzt funktioniert. Manchmal ist einfach der Wurm drin. Falls du Probleme mit der 1.1.0 hast, bitte im Forum posten. Die ist ja noch ein Testkandidat.

@epcos71
Copy link
Author

epcos71 commented Oct 31, 2020

Zu früh gefreut... Leider ist der Fehler wieder da :) Ich check mal was da jetzt anders ist...

@afuerhoff
Copy link
Owner

Ich hab noch ein update auf Github veröffentlicht. Kannst Du das mal testen. Ich hab die Fehlerbehandlung noch etwas verbessert.

@Tronje-the-Falconer
Copy link

Tronje-the-Falconer commented Nov 8, 2020 •
edited
Loading

Ich habe das gleiche Problem. Ich habe die develop Version 1.1.0 aus dem Git installiert. Der Adapter läuft jetzt dauerhaft, allerdings in Gelb. FB-Geräte erstellen und FB-Geräte neu einlesen sind beide nicht aktiviert. Sind diese Aktiviert läuft der Adapter nicht.

Folgendes Debug-Log kann ich anbieten. IP, Mac und User habe ich unkenntlich gemacht XXX YYY etc.:

fb-checkpresence.0 | 2020-11-08 20:54:50.746 | debug | (835) loopFamily ends after 40,17229896 s
-- | -- | -- | --
fb-checkpresence.0 | 2020-11-08 20:54:50.745 | warn | (835) can not get active state from member XXXX
fb-checkpresence.0 | 2020-11-08 20:54:30.736 | warn | (835) connectionCheck: "can not connect to fritzbox!"
fb-checkpresence.0 | 2020-11-08 20:54:30.735 | error | (835) soapAction /upnp/control/deviceinfo GetInfo status=ECONNABORTED errNo=5 timeout of 10000ms exceeded
fb-checkpresence.0 | 2020-11-08 20:53:25.680 | debug | (835) loopDevices ends after 0,984675 s
fb-checkpresence.0 | 2020-11-08 20:53:25.679 | debug | (835) loopDevices starts
fb-checkpresence.0 | 2020-11-08 20:53:10.676 | debug | (835) loopFamily ends after 40,56321426 s
fb-checkpresence.0 | 2020-11-08 20:53:10.675 | warn | (835) can not get active state from member XXXX
fb-checkpresence.0 | 2020-11-08 20:52:50.667 | warn | (835) connectionCheck: "can not connect to fritzbox!"
fb-checkpresence.0 | 2020-11-08 20:52:50.665 | error | (835) soapAction /upnp/control/deviceinfo GetInfo status=ECONNABORTED errNo=5 timeout of 10000ms exceeded
fb-checkpresence.0 | 2020-11-08 20:51:45.572 | debug | (835) loopDevices ends after 0,1277617 s
fb-checkpresence.0 | 2020-11-08 20:51:45.570 | debug | (835) loopDevices starts
fb-checkpresence.0 | 2020-11-08 19:51:40.554 | info | (835) createMemberObjects finished successfully
fb-checkpresence.0 | 2020-11-08 19:51:40.553 | info | (835) History function for YYYY disabled. Please select a history adapter in the configuration dialog!
fb-checkpresence.0 | 2020-11-08 19:51:40.456 | info | (835) History function for XXXX disabled. Please select a history adapter in the configuration dialog!
fb-checkpresence.0 | 2020-11-08 19:51:40.343 | info | (835) createGlobalObjects finished successfully
fb-checkpresence.0 | 2020-11-08 19:51:39.875 | info | (835) service DeviceConfig1-Reboot is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.868 | info | (835) service X_AVM-DE_HostFilter-GetWANAccessByIP is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.861 | info | (835) service X_AVM-DE_HostFilter-DisallowWANAccessByIP is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.853 | info | (835) service DeviceInfo1-GetInfo is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.845 | info | (835) service WLANConfiguration3-GetInfo is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.836 | info | (835) service WLANConfiguration3-SetEnable is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.827 | info | (835) service WANPPPConnection1-GetInfo is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.817 | info | (835) service DeviceInfo1-GetSecurityPort is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.809 | info | (835) service Hosts1-X_AVM-DE_GetSpecificHostEntryByIP is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.801 | info | (835) service Hosts1-GetSpecificHostEntry is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.793 | info | (835) service Hosts1-X_AVM-DE_GetMeshListPath is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.781 | info | (835) service Hosts1-X_AVM-DE_GetHostListPath is supported
fb-checkpresence.0 | 2020-11-08 19:51:39.771 | debug | (835) ssl-port {"status":200,"result":true,"resultData":{"$":{"xmlns:u":"urn:dslforum-org:service:DeviceInfo:1"},"NewSecurityPort":"49443"},"errNo":0,"errorMsg":""}
fb-checkpresence.0 | 2020-11-08 19:51:39.753 | debug | (835) services loaded successfully{"root":{"$":{"xmlns":"urn:dslforum-org:device-1-0"},"specVersion":{"major":"1","minor":"0"},"systemVersion":{"HW":"213","Major":"141","Minor":"7","Patch":"20","Buil
fb-checkpresence.0 | 2020-11-08 19:51:39.615 | debug | (835) configuratuion mesh info: false
fb-checkpresence.0 | 2020-11-08 19:51:39.615 | debug | (835) configuration fb-devices false
fb-checkpresence.0 | 2020-11-08 19:51:39.614 | debug | (835) configuration familymembers: [{"familymember":"XXXX","macaddress":"XX:XX:XX:XX:XX:XX","ipaddress":"XXX.XXX.X.XX","useip":true,"comment":"","enabled":true},{"familymember":"YYYY","macaddre
fb-checkpresence.0 | 2020-11-08 19:51:39.614 | debug | (835) configuration dateformat: <yyyy.dd.mmHH:MM:ss>
fb-checkpresence.0 | 2020-11-08 19:51:39.614 | debug | (835) configuration history: <>
fb-checkpresence.0 | 2020-11-08 19:51:39.613 | debug | (835) configuration user: <XXXX>
fb-checkpresence.0 | 2020-11-08 19:51:39.612 | info | (835) start fb-checkpresence: ip-address: "FFF.FFF.F.F" - interval devices: 1 Min. - interval members: 60 s
fb-checkpresence.0 | 2020-11-08 19:51:39.580 | info | (835) starting. Version 1.1.0 in /opt/iobroker/node_modules/iobroker.fb-checkpresence, node: v12.19.0, js-controller: 3.1.6

@Tronje-the-Falconer
Copy link

Nach Neustart der Fritzbox ist der Adapter nun grün!

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@Tronje-the-Falconer @afuerhoff @epcos71