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

"Create Token" isn't possible without PIN #532

Open
RP70DP opened this issue Mar 1, 2024 · 38 comments
Open

"Create Token" isn't possible without PIN #532

RP70DP opened this issue Mar 1, 2024 · 38 comments
Labels
bug Something isn't working

Comments

@RP70DP
Copy link

RP70DP commented Mar 1, 2024

Adapter version: 1.22.0
JS-Controller: 5.0.19

The "Create Token"-Button has to be clickable without specifying a PIN.

For more information please see:
ioBroker-Forum
@Apollon77 Apollon77 mentioned this issue Mar 5, 2024
Closed
@loskrachos
Copy link

I have activated "Einstellungen->Benutzerverwaltung->Benutzerrechte" and hereby generated an "Administrator-PIN". Using this PIN but Token Request fails.

@RP70DP
Copy link
Author

RP70DP commented Mar 5, 2024 •
edited

That's because if you activate "Administrator-PIN" the "System-PIN" will be deactivated. Unfortunately the "System-PIN" is still necessary for activate the token button....

@RP70DP
Copy link
Author

RP70DP commented Mar 15, 2024 •
edited

I don't know if this information is helpfull for fixing the bug: with version 1.21.1 (2024-01-15) the create token button is still working.

@loskrachos
Copy link

The button is only working, if you still have a system PIN. EQ3 removed the system PIN. The API is working fine without PIN. it is just the adapter frontend that is designed to get the system PIN as a mandatory input to make the Generate button active. Shouldn’t be a big thing.

@Apollon77 Apollon77 mentioned this issue Apr 2, 2024
Closed
@mcm1957
Copy link
Member

mcm1957 commented Apr 2, 2024

workaround see #539 (comment)

@tecfreakz
Copy link

tecfreakz commented Apr 2, 2024 •
edited

@Apollon77 @mcm1957 This issue is not the same like #539 , in 539 there is wrote from impossibility to connect the current version of this adapter to HMIP.

And it's right, it's of course a very significant bug!

Currently nobody can connect his new HMIP to iobroker with latest version of this adapter, it's not working, yet.

Here at this topic we tell about the ability to type in no pin to create a token. But it dosen't matter...on no way you can create a token and get your HMIP working with iobroker, not with and not without pin, if you try to create a token everytime in logs comes this error:
image

Just a fallback to an older version ≤1.19 gives the ability to Set up an new HMIP connection to iobroker.

Please fix it highly prioritized!

@Apollon77
Copy link
Member

@GermanBluefox Please make the PIN an optional field in jsconfig and mainly also in the custom component. Thank you

@loskrachos
Copy link

@GermanBluefox I just pulled the 1.23 from the beta repository and created a new instance from that. Token creation without filling the PIN Field is still not possible. Wasn't this the aim of that fix?

@mcm1957
Copy link
Member

mcm1957 commented Apr 29, 2024

I'm not aware that 1.23.0 conatins any code changes. Please see changelog.

I'll check why this issue has been marked fixed.

@mcm1957 mcm1957 added the bug Something isn't working label Apr 29, 2024
@tecfreakz
Copy link

The dev seems not understand, which the problem is about, isn't it? 🙈

@mcm1957
Copy link
Member

mcm1957 commented Apr 29, 2024

The dev seems not understand, which the problem is about, isn't it? 🙈

No that's definitly not the problem. Either the change was lost on the way between dev system and githubg (aka was not comiited) or the setting of "fixed" was done on error. At the moment this issue must be considered "not fixed". Release 1.23.0 was created due to chnages in test enviroment is independent of this issue.

@mcm1957 mcm1957 removed the fixed label Apr 29, 2024
@loskrachos
Copy link

As this adapter is not usable for any Access Point that needs to be connected to ioBroker it would really be great if there could be a fix. It was reported almost 2 month ago.
I really appreciate the work of all devs but it is not even a hard bug as the API is supporting token creation without PIN. Could this issue please be prioritized and fixed. Thanks in advance!

@Apollon77
Copy link
Member

In fact 1.23 was never supposed to contain the fix and was published before ... so please donot confuse things. es we will clrify why Denis set fixed :-)

GermanBluefox added a commit that referenced this issue Apr 30, 2024
@GermanBluefox
#532: #532
b8f4dbe
@Apollon77
Copy link
Member

Ok, now commit is there. So if anyone likes please try GitHub version ...

@loskrachos
Copy link

Ok, now commit is there. So if anyone likes please try GitHub version ...

I tried, using the "Installieren aus eigener URL" --> GitHub --> hmip function.

Bildschirmfoto 2024-04-30 um 10 42 15

Without PIN the "TOKEN ERSTELLEN" button is still deactivated.
Bildschirmfoto 2024-04-30 um 10 44 19

@loskrachos
Copy link

I corrected the second part - F711 - no difference

@GermanBluefox
Copy link
Member

GermanBluefox commented Apr 30, 2024 •
edited

tabs

Works by me.
May be iob u hmip ?

@Apollon77
Copy link
Member

Ok I will prepare a release

@mcm1957 mcm1957 added the fixed label Apr 30, 2024
@mcm1957
Copy link
Member

mcm1957 commented Apr 30, 2024 •
edited

@loskrachos wrote at 29.4.2024:

@GermanBluefox I just pulled the 1.23 from the beta repository and created a new instance from that. Token creation without filling the PIN Field is still not possible. Wasn't this the aim of that fix?

One additional question / remark - not really related to problem but to clearify what you have installed at which time:
How did you manage to pull 1.23 from beta repository while 1.23 never was available at beta repository?

image
image

@loskrachos
Copy link

I switched to Beta releases and was able to install 1.23 from the release list 🤷‍♂️

@mcm1957
Copy link
Member

mcm1957 commented Apr 30, 2024

fixed with 1.23.1

@mcm1957 mcm1957 closed this as completed Apr 30, 2024
@loskrachos
Copy link

Sorry for spamming this thread but idk what goes wrong. I am on a test system. only installed adapters:
Bildschirmfoto 2024-04-30 um 21 19 27
I get the hmip version 1.23.1 from github, add an instance and the button stays inactive, no matter if i enter a valid sgtin or just random numbers as you demonstrated.
Bildschirmfoto 2024-04-30 um 21 24 22

@mcm1957
Copy link
Member

mcm1957 commented Apr 30, 2024 •
edited

You do not spam if you report a problem. Don't worry. BUT: Nobody told you to install from github. Installing from github should be done ONLY when adviced by developer. Releases at Github can contain any intermediate and even non working or broken code,

Please install using latest repository and either admin interface (preferred) or iobroker cli command.

@loskrachos
Copy link

Thought it might be helpful… testing it asap. when do you think it is released? I have no experience how long it takes from commit to the release.

@Apollon77
Copy link
Member

npm released, should become in latest over night

@mcm1957
Copy link
Member

mcm1957 commented May 1, 2024

npm released, should become in latest over night

Was available short after creating the release. I did an extra update due to urgency. So attime of my last posting it was already available at latest.

Please check latest always when waiting for a fix. And use Check for updates" button to refresh your local cache too (local cache is normally updates only once a day)

@loskrachos
Copy link

I am going nuts... "TOKEN GENERIEREN" is now active, as soon as I enter anything. Thanks for that!

But Token generation isn't working. I have set up a completely new ioBroker on Raspi4 - only adapter I installed additionally was hmip 1.23.1 from beta repository. (in stable only 1.22 is available)

I enter SGTIN and get immediately "Während der Token-Generierung ist ein Fehler aufgetreten. Sehen Sie sich die Protokolle an"

System completely new and clean
Router restarted
Raspi restarted
I tried with 2 different HM APs - same behavior

--> if you like we can have a remote session to give you the chance to get more information

Protocol:

2024-05-01 20:20:29.550  - �[35msilly�[39m: hmip.0 (846) States system redis pmessage io.messagebox.system.adapter.hmip.0/io.messagebox.system.adapter.hmip.0:{"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":22,"ack":false,"time":1714587629548},"_id":45960483}
2024-05-01 20:20:29.551  - �[34mdebug�[39m: hmip.0 (846) message received - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":22,"ack":false,"time":1714587629548},"_id":45960483}
2024-05-01 20:20:29.552  - �[35msilly�[39m: hmip.0 (846) sendTo "requestTokenState" to system.adapter.admin.0 from system.adapter.hmip.0
2024-05-01 20:20:32.597  - �[35msilly�[39m: hmip.0 (846) States system redis pmessage io.messagebox.system.adapter.hmip.0/io.messagebox.system.adapter.hmip.0:{"command":"requestToken","message":{"accessPointSgtin":"3014-F711-A000-XXXX-YYYY-ZZZZ","clientId":"","pin":"","deviceName":"iobroker"},"from":"system.adapter.admin.0","callback":{"message":{"accessPointSgtin":"3014-F711-A000-XXXX-YYYY-ZZZZ","clientId":"","pin":"","deviceName":"iobroker"},"id":23,"ack":false,"time":1714587632595},"_id":45960484}
2024-05-01 20:20:32.599  - �[34mdebug�[39m: hmip.0 (846) message received - {"command":"requestToken","message":{"accessPointSgtin":"3014-F711-A000-XXXX-YYYY-ZZZZ","clientId":"","pin":"","deviceName":"iobroker"},"from":"system.adapter.admin.0","callback":{"message":{"accessPointSgtin":"3014-F711-A000-XXXX-YYYY-ZZZZ","clientId":"","pin":"","deviceName":"iobroker"},"id":23,"ack":false,"time":1714587632595},"_id":45960484}
2024-05-01 20:20:32.599  - �[35msilly�[39m: hmip.0 (846) sendTo "requestToken" to system.adapter.admin.0 from system.adapter.hmip.0
2024-05-01 20:20:32.600  - �[32minfo�[39m: hmip.0 (846) started token request
2024-05-01 20:20:32.676  - �[32minfo�[39m: hmip.0 (846) auth step 1
2024-05-01 20:20:32.772  - �[33mwarn�[39m: hmip.0 (846) Request error data: [object Object]
2024-05-01 20:20:32.772  - �[33mwarn�[39m: hmip.0 (846) Request error status: 403
2024-05-01 20:20:32.773  - �[31merror�[39m: hmip.0 (846) error requesting token: Error: error
2024-05-01 20:20:32.913  - �[35msilly�[39m: hmip.0 (846) States system redis pmessage io.messagebox.system.adapter.hmip.0/io.messagebox.system.adapter.hmip.0:{"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":24,"ack":false,"time":1714587632911},"_id":45960485}
2024-05-01 20:20:32.915  - �[34mdebug�[39m: hmip.0 (846) message received - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":24,"ack":false,"time":1714587632911},"_id":45960485}
2024-05-01 20:20:32.915  - �[35msilly�[39m: hmip.0 (846) sendTo "requestTokenState" to system.adapter.admin.0 from system.adapter.hmip.0

@mcm1957
Copy link
Member

mcm1957 commented May 1, 2024 •
edited

OK - I'll reopen of course and ask dev to check.

@mcm1957 mcm1957 reopened this May 1, 2024
@mcm1957 mcm1957 removed the fixed label May 1, 2024
@mcm1957
Copy link
Member

mcm1957 commented May 1, 2024

Thanks for the complet log provided.
I'm sorry to say but at the moment no dev with a matching hardware is available.

In the meantime I would like to ask whether you could try to install an older working adapter version and to create a debug log with working token generation. Maybe we could detect the difference with this information.

@loskrachos
Copy link

anything that might be helpful... but is there really an older version, that can handle the APs with the "switched off" System PIN? As written, I can also offer to support a remote session with my hardware. It is a test system, we can do whatever neccessary. We can temporarily switch to mail or other communication channels (WA etc.) I would really be happy to support! just mailto:loskrachos@gmx.de
If no other option I had also another WiFi AP I don't use anymore. I could "donate" it.

@mcm1957
Copy link
Member

mcm1957 commented May 1, 2024

Well, there :
#539 (comment)
seems to be a description for work around.

I do not have any HMIP HW so I do not really know hwo to use and it makes no sense to try a remote session. Sorry. The main dev is currently busy outside germany and cannot work on this at the meoment.

@tecfreakz
Copy link

tecfreakz commented May 1, 2024 •
edited

Hi Guys,

i agree to that, with a version >1.20 it's not possible to generate a token yet and in last consequence this adapter in newest version is broken and for new users or new installed systems currently useless caused of impossibility to register/first connect with an hmip gateway.

The used hardwae dosen't matter, i've tested it on proxmox, fully installed Debian, Ubuntu and in rpi4 and 5 with raspbian and ubuntu, in every systemscenario the same issue (No token generation possible).

Strongly need a Dev now to check/analyze and fix, it's a major bug (this adapter is partly unusable a few months ago since release of 1.20!) and should be max prioritized.

My workaround at #539 (comment) works well, but this shouldn''t be best solution to get the iobroker work with hmip.

Kind regards

@loskrachos
Copy link

I just tried the workaround and indeed it is working!

Here is the Log: (only debug, not silly)

2024-05-01 22:50:58.714  - �[34mdebug�[39m: hmip.0 (1377) ready
2024-05-01 22:50:58.716  - �[32minfo�[39m: hmip.0 (1377) token not yet created
2024-05-01 22:51:03.100  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestToken","message":{"accessPointSgtin":"3014-F711-A000-XXXX-YYYY-ZZZZ","clientId":"","pin":"","deviceName":"iobroker"},"from":"system.adapter.admin.0","callback":{"message":{"accessPointSgtin":"3014-F711-A000-XXXX-YYYY-ZZZZ","clientId":"","pin":"","deviceName":"iobroker"},"id":1649,"ack":false,"time":1714596663098},"_id":45962118}
2024-05-01 22:51:03.103  - �[32minfo�[39m: hmip.0 (1377) started token request
2024-05-01 22:51:03.226  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1650,"ack":false,"time":1714596663112},"_id":45962119}
2024-05-01 22:51:03.237  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1651,"ack":false,"time":1714596663235},"_id":45962120}
2024-05-01 22:51:03.248  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1652,"ack":false,"time":1714596663247},"_id":45962121}
2024-05-01 22:51:03.259  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1653,"ack":false,"time":1714596663257},"_id":45962122}
2024-05-01 22:51:03.270  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1654,"ack":false,"time":1714596663268},"_id":45962123}
2024-05-01 22:51:03.289  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1655,"ack":false,"time":1714596663280},"_id":45962124}
2024-05-01 22:51:03.300  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1656,"ack":false,"time":1714596663298},"_id":45962125}
2024-05-01 22:51:03.311  - �[32minfo�[39m: hmip.0 (1377) auth step 1
2024-05-01 22:51:03.324  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1657,"ack":false,"time":1714596663309},"_id":45962126}
2024-05-01 22:51:03.335  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1658,"ack":false,"time":1714596663333},"_id":45962127}
2024-05-01 22:51:03.346  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1659,"ack":false,"time":1714596663344},"_id":45962128}
2024-05-01 22:51:03.359  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1660,"ack":false,"time":1714596663355},"_id":45962129}
2024-05-01 22:51:03.371  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1661,"ack":false,"time":1714596663369},"_id":45962130}
2024-05-01 22:51:03.382  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1662,"ack":false,"time":1714596663380},"_id":45962131}
2024-05-01 22:51:03.393  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1663,"ack":false,"time":1714596663392},"_id":45962132}
2024-05-01 22:51:03.405  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1664,"ack":false,"time":1714596663403},"_id":45962133}
2024-05-01 22:51:03.419  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1665,"ack":false,"time":1714596663414},"_id":45962134}
2024-05-01 22:51:03.428  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1666,"ack":false,"time":1714596663427},"_id":45962135}
2024-05-01 22:51:03.440  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1667,"ack":false,"time":1714596663438},"_id":45962136}
2024-05-01 22:51:03.450  - �[32minfo�[39m: hmip.0 (1377) auth step 2
2024-05-01 22:51:03.461  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1668,"ack":false,"time":1714596663448},"_id":45962137}
2024-05-01 22:51:03.472  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1669,"ack":false,"time":1714596663471},"_id":45962138}
2024-05-01 22:51:03.484  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1670,"ack":false,"time":1714596663482},"_id":45962139}
2024-05-01 22:51:03.494  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1671,"ack":false,"time":1714596663493},"_id":45962140}
2024-05-01 22:51:03.505  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1672,"ack":false,"time":1714596663503},"_id":45962141}

**now i cropped a few repeating lines, as I almost forgot to press the button on the AP ;-)**

2024-05-01 22:51:12.763  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":2505,"ack":false,"time":1714596672762},"_id":45962974}
2024-05-01 22:51:12.775  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":2506,"ack":false,"time":1714596672773},"_id":45962975}
2024-05-01 22:51:12.786  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":2507,"ack":false,"time":1714596672784},"_id":45962976}
2024-05-01 22:51:12.835  - �[32minfo�[39m: admin.0 (751) <== Disconnect system.user.admin from ::ffff:192.168.188.5 
2024-05-01 22:51:30.617  - �[32minfo�[39m: hmip.0 (1377) auth step 3
2024-05-01 22:51:37.854  - �[32minfo�[39m: admin.0 (751) ==> Connected system.user.admin from ::ffff:192.168.188.5
2024-05-01 22:51:37.954  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":2511,"ack":false,"time":1714596697952},"_id":45962980}
2024-05-01 22:51:43.665  - �[32minfo�[39m: host.smarterfranke stopInstance system.adapter.hmip.0 (force=false, process=true)
2024-05-01 22:51:43.673  - �[32minfo�[39m: hmip.0 (1377) Got terminate signal TERMINATE_YOURSELF
2024-05-01 22:51:43.676  - �[32minfo�[39m: hmip.0 (1377) cleaned everything up...
2024-05-01 22:51:43.677  - �[32minfo�[39m: hmip.0 (1377) terminating
2024-05-01 22:51:43.679  - �[34mdebug�[39m: hmip.0 (1377) Plugin sentry destroyed
2024-05-01 22:51:43.680  - �[32minfo�[39m: hmip.0 (1377) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
2024-05-01 22:51:43.745  - �[32minfo�[39m: host.smarterfranke stopInstance system.adapter.hmip.0 send kill signal
2024-05-01 22:51:43.769  - �[32minfo�[39m: admin.0 (751) <== Disconnect system.user.admin from ::ffff:192.168.188.5 
2024-05-01 22:51:44.182  - �[32minfo�[39m: hmip.0 (1377) terminating
2024-05-01 22:51:44.222  - �[32minfo�[39m: host.smarterfranke instance system.adapter.hmip.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2024-05-01 22:51:46.775  - �[32minfo�[39m: host.smarterfranke instance system.adapter.hmip.0 started with pid 1392
2024-05-01 22:51:48.404  - �[34mdebug�[39m: hmip.0 (1392) Redis Objects: Use Redis connection: 127.0.0.1:9001
2024-05-01 22:51:48.435  - �[34mdebug�[39m: hmip.0 (1392) Objects client ready ... initialize now
2024-05-01 22:51:48.438  - �[34mdebug�[39m: hmip.0 (1392) Objects create System PubSub Client
2024-05-01 22:51:48.440  - �[34mdebug�[39m: hmip.0 (1392) Objects create User PubSub Client
2024-05-01 22:51:48.461  - �[34mdebug�[39m: hmip.0 (1392) Objects client initialize lua scripts
2024-05-01 22:51:48.470  - �[34mdebug�[39m: hmip.0 (1392) Objects connected to redis: 127.0.0.1:9001
2024-05-01 22:51:48.488  - �[34mdebug�[39m: hmip.0 (1392) Redis States: Use Redis connection: 127.0.0.1:9000
2024-05-01 22:51:48.496  - �[34mdebug�[39m: hmip.0 (1392) States create System PubSub Client
2024-05-01 22:51:48.497  - �[34mdebug�[39m: hmip.0 (1392) States create User PubSub Client
2024-05-01 22:51:48.510  - �[34mdebug�[39m: hmip.0 (1392) States connected to redis: 127.0.0.1:9000
2024-05-01 22:51:48.541  - �[34mdebug�[39m: hmip.0 (1392) Plugin sentry Initialize Plugin (enabled=true)
2024-05-01 22:51:49.050  - �[32minfo�[39m: hmip.0 (1392) starting. Version 1.19.2 in /opt/iobroker/node_modules/iobroker.hmip, node: v18.20.2, js-controller: 5.0.19
2024-05-01 22:51:49.073  - �[34mdebug�[39m: hmip.0 (1392) ready
2024-05-01 22:51:49.707  - �[34mdebug�[39m: hmip.0 (1392) createObjectsForDevices
2024-05-01 22:51:49.802  - �[34mdebug�[39m: hmip.0 (1392) createObjectsForGroups
2024-05-01 22:51:50.558  - �[34mdebug�[39m: hmip.0 (1392) createObjectsForClients
2024-05-01 22:51:50.657  - �[34mdebug�[39m: hmip.0 (1392) createObjectsForHomes
2024-05-01 22:51:50.757  - �[34mdebug�[39m: hmip.0 (1392) connectWebsocket
2024-05-01 22:51:50.765  - �[34mdebug�[39m: hmip.0 (1392) updateDeviceStates
2024-05-01 22:51:50.837  - �[32minfo�[39m: hmip.0 (1392) ws connection opened
2024-05-01 22:51:51.729  - �[34mdebug�[39m: hmip.0 (1392) subscribeStates
2024-05-01 22:51:51.732  - �[32minfo�[39m: hmip.0 (1392) hmip adapter connected and ready

@tecfreakz
Copy link

I just tried the workaround and indeed it is working!

Here is the Log: (only debug, not silly)

2024-05-01 22:50:58.714  - �[34mdebug�[39m: hmip.0 (1377) ready
2024-05-01 22:50:58.716  - �[32minfo�[39m: hmip.0 (1377) token not yet created
2024-05-01 22:51:03.100  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestToken","message":{"accessPointSgtin":"3014-F711-A000-XXXX-YYYY-ZZZZ","clientId":"","pin":"","deviceName":"iobroker"},"from":"system.adapter.admin.0","callback":{"message":{"accessPointSgtin":"3014-F711-A000-XXXX-YYYY-ZZZZ","clientId":"","pin":"","deviceName":"iobroker"},"id":1649,"ack":false,"time":1714596663098},"_id":45962118}
2024-05-01 22:51:03.103  - �[32minfo�[39m: hmip.0 (1377) started token request
2024-05-01 22:51:03.226  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1650,"ack":false,"time":1714596663112},"_id":45962119}
2024-05-01 22:51:03.237  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1651,"ack":false,"time":1714596663235},"_id":45962120}
2024-05-01 22:51:03.248  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1652,"ack":false,"time":1714596663247},"_id":45962121}
2024-05-01 22:51:03.259  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1653,"ack":false,"time":1714596663257},"_id":45962122}
2024-05-01 22:51:03.270  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1654,"ack":false,"time":1714596663268},"_id":45962123}
2024-05-01 22:51:03.289  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1655,"ack":false,"time":1714596663280},"_id":45962124}
2024-05-01 22:51:03.300  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1656,"ack":false,"time":1714596663298},"_id":45962125}
2024-05-01 22:51:03.311  - �[32minfo�[39m: hmip.0 (1377) auth step 1
2024-05-01 22:51:03.324  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1657,"ack":false,"time":1714596663309},"_id":45962126}
2024-05-01 22:51:03.335  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1658,"ack":false,"time":1714596663333},"_id":45962127}
2024-05-01 22:51:03.346  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1659,"ack":false,"time":1714596663344},"_id":45962128}
2024-05-01 22:51:03.359  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1660,"ack":false,"time":1714596663355},"_id":45962129}
2024-05-01 22:51:03.371  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1661,"ack":false,"time":1714596663369},"_id":45962130}
2024-05-01 22:51:03.382  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1662,"ack":false,"time":1714596663380},"_id":45962131}
2024-05-01 22:51:03.393  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1663,"ack":false,"time":1714596663392},"_id":45962132}
2024-05-01 22:51:03.405  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1664,"ack":false,"time":1714596663403},"_id":45962133}
2024-05-01 22:51:03.419  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1665,"ack":false,"time":1714596663414},"_id":45962134}
2024-05-01 22:51:03.428  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1666,"ack":false,"time":1714596663427},"_id":45962135}
2024-05-01 22:51:03.440  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1667,"ack":false,"time":1714596663438},"_id":45962136}
2024-05-01 22:51:03.450  - �[32minfo�[39m: hmip.0 (1377) auth step 2
2024-05-01 22:51:03.461  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1668,"ack":false,"time":1714596663448},"_id":45962137}
2024-05-01 22:51:03.472  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1669,"ack":false,"time":1714596663471},"_id":45962138}
2024-05-01 22:51:03.484  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1670,"ack":false,"time":1714596663482},"_id":45962139}
2024-05-01 22:51:03.494  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1671,"ack":false,"time":1714596663493},"_id":45962140}
2024-05-01 22:51:03.505  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":1672,"ack":false,"time":1714596663503},"_id":45962141}

**now i cropped a few repeating lines, as I almost forgot to press the button on the AP ;-)**

2024-05-01 22:51:12.763  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":2505,"ack":false,"time":1714596672762},"_id":45962974}
2024-05-01 22:51:12.775  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":2506,"ack":false,"time":1714596672773},"_id":45962975}
2024-05-01 22:51:12.786  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":2507,"ack":false,"time":1714596672784},"_id":45962976}
2024-05-01 22:51:12.835  - �[32minfo�[39m: admin.0 (751) <== Disconnect system.user.admin from ::ffff:192.168.188.5 
2024-05-01 22:51:30.617  - �[32minfo�[39m: hmip.0 (1377) auth step 3
2024-05-01 22:51:37.854  - �[32minfo�[39m: admin.0 (751) ==> Connected system.user.admin from ::ffff:192.168.188.5
2024-05-01 22:51:37.954  - �[34mdebug�[39m: hmip.0 (1377) message recieved - {"command":"requestTokenState","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":2511,"ack":false,"time":1714596697952},"_id":45962980}
2024-05-01 22:51:43.665  - �[32minfo�[39m: host.smarterfranke stopInstance system.adapter.hmip.0 (force=false, process=true)
2024-05-01 22:51:43.673  - �[32minfo�[39m: hmip.0 (1377) Got terminate signal TERMINATE_YOURSELF
2024-05-01 22:51:43.676  - �[32minfo�[39m: hmip.0 (1377) cleaned everything up...
2024-05-01 22:51:43.677  - �[32minfo�[39m: hmip.0 (1377) terminating
2024-05-01 22:51:43.679  - �[34mdebug�[39m: hmip.0 (1377) Plugin sentry destroyed
2024-05-01 22:51:43.680  - �[32minfo�[39m: hmip.0 (1377) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
2024-05-01 22:51:43.745  - �[32minfo�[39m: host.smarterfranke stopInstance system.adapter.hmip.0 send kill signal
2024-05-01 22:51:43.769  - �[32minfo�[39m: admin.0 (751) <== Disconnect system.user.admin from ::ffff:192.168.188.5 
2024-05-01 22:51:44.182  - �[32minfo�[39m: hmip.0 (1377) terminating
2024-05-01 22:51:44.222  - �[32minfo�[39m: host.smarterfranke instance system.adapter.hmip.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2024-05-01 22:51:46.775  - �[32minfo�[39m: host.smarterfranke instance system.adapter.hmip.0 started with pid 1392
2024-05-01 22:51:48.404  - �[34mdebug�[39m: hmip.0 (1392) Redis Objects: Use Redis connection: 127.0.0.1:9001
2024-05-01 22:51:48.435  - �[34mdebug�[39m: hmip.0 (1392) Objects client ready ... initialize now
2024-05-01 22:51:48.438  - �[34mdebug�[39m: hmip.0 (1392) Objects create System PubSub Client
2024-05-01 22:51:48.440  - �[34mdebug�[39m: hmip.0 (1392) Objects create User PubSub Client
2024-05-01 22:51:48.461  - �[34mdebug�[39m: hmip.0 (1392) Objects client initialize lua scripts
2024-05-01 22:51:48.470  - �[34mdebug�[39m: hmip.0 (1392) Objects connected to redis: 127.0.0.1:9001
2024-05-01 22:51:48.488  - �[34mdebug�[39m: hmip.0 (1392) Redis States: Use Redis connection: 127.0.0.1:9000
2024-05-01 22:51:48.496  - �[34mdebug�[39m: hmip.0 (1392) States create System PubSub Client
2024-05-01 22:51:48.497  - �[34mdebug�[39m: hmip.0 (1392) States create User PubSub Client
2024-05-01 22:51:48.510  - �[34mdebug�[39m: hmip.0 (1392) States connected to redis: 127.0.0.1:9000
2024-05-01 22:51:48.541  - �[34mdebug�[39m: hmip.0 (1392) Plugin sentry Initialize Plugin (enabled=true)
2024-05-01 22:51:49.050  - �[32minfo�[39m: hmip.0 (1392) starting. Version 1.19.2 in /opt/iobroker/node_modules/iobroker.hmip, node: v18.20.2, js-controller: 5.0.19
2024-05-01 22:51:49.073  - �[34mdebug�[39m: hmip.0 (1392) ready
2024-05-01 22:51:49.707  - �[34mdebug�[39m: hmip.0 (1392) createObjectsForDevices
2024-05-01 22:51:49.802  - �[34mdebug�[39m: hmip.0 (1392) createObjectsForGroups
2024-05-01 22:51:50.558  - �[34mdebug�[39m: hmip.0 (1392) createObjectsForClients
2024-05-01 22:51:50.657  - �[34mdebug�[39m: hmip.0 (1392) createObjectsForHomes
2024-05-01 22:51:50.757  - �[34mdebug�[39m: hmip.0 (1392) connectWebsocket
2024-05-01 22:51:50.765  - �[34mdebug�[39m: hmip.0 (1392) updateDeviceStates
2024-05-01 22:51:50.837  - �[32minfo�[39m: hmip.0 (1392) ws connection opened
2024-05-01 22:51:51.729  - �[34mdebug�[39m: hmip.0 (1392) subscribeStates
2024-05-01 22:51:51.732  - �[32minfo�[39m: hmip.0 (1392) hmip adapter connected and ready

Congratulations 😉

But this adapter in latest versions is still not working for token generation, strongly a bugfix needed.

@hahn-th
Copy link

hahn-th commented May 2, 2024

Hi there.
Has IQ3(HomematicIP-Cloud) changed anything in the interface or the Auth-Token process or does this only affect the ioBroker adapter?

@overwerk
Copy link

overwerk commented May 2, 2024

The old version (1.21.1 from January) of the adapter is still working fine. So I assume its just a bug in the newer versions. Probably no one tested to add a new device.

@RP70DP
Copy link
Author

RP70DP commented May 2, 2024

@GermanBluefox

Can you please recheck the following commit:

  • Module require has been replaced by axios

@mcm1957
Copy link
Member

mcm1957 commented May 2, 2024 •
edited

Hi there. Has IQ3(HomematicIP-Cloud) changed anything in the interface or the Auth-Token process or does this only affect the ioBroker adapter?

It's most likely a problem with the adapter.
Bluefox will check as soon he has time to do this.

And thanks to all who provided logs. Maybe this will help to identify the difference.

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

No branches or pull requests
8 participants
@GermanBluefox @Apollon77 @tecfreakz @hahn-th @overwerk @mcm1957 @RP70DP @loskrachos