Signing: no active verification session?

[tomkxy]

Continuation of test details

TEST 4

• Node is using soft signing, GW ATSHA204 signing
• Node and gateway on pull request code
• Controller has time delays between time response send and state message

RESULT:

• Failed

Note: I just realized that I have in the beginning a couple of transmission errors which is due to he fact that I needed to bring the node and gateway probably to close together in order to get the gateway logs.
I will repeat this test!

Log file form node

Starting sensor (RNNNAS, 2.0.0-beta)
Radio init successful.
Signing required
Skipping security for command 3 type 15
send: 32-32-24-0 s=255,c=3,t=15,pt=0,l=2,sg=0,st=fail:


Waiting for GW to send signing preferences...
Skipping security for command 3 type 16
send: 32-32-24-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=fail:
Failed to transmit nonce request!
sign fail
send: 32-32-24-0 s=255,c=0,t=17,pt=0,l=10,sg=0,st=fail:2.0.0-beta
Skipping security for command 3 type 16
send: 32-32-24-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=fail:
Failed to transmit nonce request!
sign fail
send: 32-32-24-0 s=255,c=3,t=6,pt=1,l=1,sg=0,st=fail:24
Skipping security for command 3 type 16
send: 32-32-24-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=fail:
find parent
send: 32-32-255-255 s=255,c=3,t=7,pt=0,l=0,sg=0,st=bc:
Skipping security for command 3 type 8
read: 0-0-32 s=255,c=3,t=8,pt=1,l=1,sg=0:0
parent=0, d=1
Failed to transmit nonce request!
sign fail
send: 0-32-0-32 s=255,c=3,t=8,pt=1,l=1,sg=0,st=ok:0
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:9D0A6F87CD7824856F6C5F86135DF9C205A52172154E2ECAA8
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 20001E030CFF312E35
Current nonce: 9D0A6F87CD7824856F6C5F86135DF9C205A52172154E2ECAA8AAAAAAAAAAAAAA
HMAC: 1B03C1339C72E52DE7ADA8312983CE2853E8E4CF7A88C262250900388FFDD1F8
Signature in message: 0103C1339C72E52DE7ADA8312983CE2853E8E4CF7A88
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=12,pt=0,l=3,sg=1,st=ok:1.5
Skipping security for command 3 type 16
send: 32-32-0-0 s=0,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:F6B9819CA822EECEE953357A43742393B952BB5C152C601208
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 200006001F00
Current nonce: F6B9819CA822EECEE953357A43742393B952BB5C152C601208AAAAAAAAAAAAAA
HMAC: A74B8E7B71B7F614D6E4DA7E1817459E5F15C26D5A75CA57B1723E9EEC5FC248
Signature in message: 014B8E7B71B7F614D6E4DA7E1817459E5F15C26D5A75CA57B1
Message signed
Message to send has been signed
send: 32-32-0-0 s=0,c=0,t=31,pt=0,l=0,sg=1,st=ok:
Init complete, id=32, parent=0, distance=1
------------- Start request time ------------
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:D84804E29BF6B78CC1F7823E860D19378D399472D3D3A43D6F
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 2000060301FF
Current nonce: D84804E29BF6B78CC1F7823E860D19378D399472D3D3A43D6FAAAAAAAAAAAAAA
HMAC: CE335FA0706A8C57678547FA4DD9528BDE7AA9401607B3920C79DB515C630B46
Signature in message: 01335FA0706A8C57678547FA4DD9528BDE7AA9401607B3920C
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=1,pt=0,l=0,sg=1,st=ok:

Log file from gateway:

0;255;3;0;9;Starting gateway (RNNGAA, 2.0.0-beta)
0;255;3;0;9;Radio init successful.
0;255;3;0;9;Init complete, id=0, parent=0, distance=0
0;255;3;0;9;Attempting MQTT connection...
0;255;3;0;9;MQTT connected
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 1F0846076C5AD7D094CA224A960CF66CB67F5E6CB4BD0EEDD2EE290975E1CAAD
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:1F0846076C5AD7D094CA224A960CF66CB67F5E6CB4BD0EEDD2
0;255;3;0;9;Signature in message: 01E921AD315EFBDA944E6F9F1A7FB21BFD2FD798E2C212CB0E
0;255;3;0;9;Message to process: 2000060301FF
0;255;3;0;9;Current nonce: 1F0846076C5AD7D094CA224A960CF66CB67F5E6CB4BD0EEDD2AAAAAAAAAAAAAA
0;255;3;0;9;HMAC: 7C952EBD4EE51B758DA5BFA19E14F01DA5CD375882CE6CAA316F5A5117BA8A54
0;255;3;0;9;Signature bad: 01952EBD4EE51B758DA5BFA19E14F01DA5CD375882CE6CAA31
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail

TEST 5

• ATSHA204 signing
• Node and gateway on pull request code
• Removed delays between send in controller

RESULT:

• OK

Starting sensor (RNNNAA, 2.0.0-beta)
Radio init successful.
Signing required
Skipping security for command 3 type 15
send: 32-32-0-0 s=255,c=3,t=15,pt=0,l=2,sg=0,st=ok:


Waiting for GW to send signing preferences...
Skipping security for command 3 type 15
read: 0-0-32 s=255,c=3,t=15,pt=0,l=2,sg=0:


Mark node 0 as one that require signed messages
Mark node 0 as one that do not require whitelisting
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:FE59BF15C57BFEE2694AC0808D7E9C1F92739CBD6188E1674E
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 2000560011FF322E302E302D62657461
Current nonce: FE59BF15C57BFEE2694AC0808D7E9C1F92739CBD6188E1674EAAAAAAAAAAAAAA
HMAC: D627F8CC1ED41A9CC0067FFCA8F2DE919BB51348B20748E8E2406BAF2C96BD76
Signature in message: 0127F8CC1ED41A9CC0067FFCA8F2DE
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=0,t=17,pt=0,l=10,sg=1,st=ok:2.0.0-beta
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:A630B1C776C8759946C7F58EA263CA7683B59D828F8161B78F
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 20000E2306FF00
Current nonce: A630B1C776C8759946C7F58EA263CA7683B59D828F8161B78FAAAAAAAAAAAAAA
HMAC: F4D362400F33CCE581E3A97E40CF7F1AE74ACAB8ED2E97A21E10E4A43B9B619A
Signature in message: 01D362400F33CCE581E3A97E40CF7F1AE74ACAB8ED2E97A2
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=6,pt=1,l=1,sg=1,st=ok:0
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:CA7A11B0F5EE59A28ADCA0AC74FEFCFD59F430893E548992A9
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 20008E030BFF53656E736562656E646572204D6963726F
Current nonce: CA7A11B0F5EE59A28ADCA0AC74FEFCFD59F430893E548992A9AAAAAAAAAAAAAA
HMAC: 50EBEE0FCE4DDE0CCF63294D4DD6D142D958B9763F206A42219D7B701D184C1D
Signature in message: 01EBEE0FCE4DDE0C
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=11,pt=0,l=17,sg=1,st=ok:Sensebender Micro
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:C505BE34F06A7DF14012B6096C41268BF35B06A0C14D276F70
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 20001E030CFF312E35
Current nonce: C505BE34F06A7DF14012B6096C41268BF35B06A0C14D276F70AAAAAAAAAAAAAA
HMAC: 7DB23045C8B4AE6AE1D49263C36B204781530088F9D6D082B3C11F01C991573A
Signature in message: 01B23045C8B4AE6AE1D49263C36B204781530088F9D6
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=12,pt=0,l=3,sg=1,st=ok:1.5
Skipping security for command 3 type 16
send: 32-32-0-0 s=0,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:5F3E459CE02B989081990670A0EFC390FB800F5083B961806B
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 200006001F00
Current nonce: 5F3E459CE02B989081990670A0EFC390FB800F5083B961806BAAAAAAAAAAAAAA
HMAC: C233B208BCB7B838FD0E2643453510BA9D4B4CA507626C646569B4723508C7E6
Signature in message: 0133B208BCB7B838FD0E2643453510BA9D4B4CA507626C6465
Message signed
Message to send has been signed
send: 32-32-0-0 s=0,c=0,t=31,pt=0,l=0,sg=1,st=ok:
Init complete, id=32, parent=0, distance=1
------------- Start request time ------------
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:5284D3E4DDB1653B612D386C5639215EB2D586CD13F538E44C
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 2000060301FF
Current nonce: 5284D3E4DDB1653B612D386C5639215EB2D586CD13F538E44CAAAAAAAAAAAAAA
HMAC: 64324E13B3D277F3DAD2F213854702DDC1C56290462A44387C16B9B05C927EB3
Signature in message: 01324E13B3D277F3DAD2F213854702DDC1C56290462A44387C
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=1,pt=0,l=0,sg=1,st=ok:
Skipping security for command 3 type 16
read: 0-0-32 s=255,c=3,t=16,pt=0,l=0,sg=0:
Signing backend: ATSHA204
SHA256: 051A42C2D547A6501D825592655382F46097B940CB2A9BC7862764640382A6F4
Transmittng nonce
Skipping security for command 3 type 17
send: 32-32-0-0 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:051A42C2D547A6501D825592655382F46097B940CB2A9BC786
Signature in message: 013DA95E35B18396C1610C640882FC
Message to process: 0020560301FF31343635323836313037
Current nonce: 051A42C2D547A6501D825592655382F46097B940CB2A9BC786AAAAAAAAAAAAAA
HMAC: 083DA95E35B18396C1610C640882FC8F7A73BB2F36C4CCB622978F14F8DCF88E
Signature OK
read: 0-0-32 s=255,c=3,t=1,pt=0,l=10,sg=0:1465286107
Time value received and updated...
Skipping security for command 3 type 16
read: 0-0-32 s=0,c=3,t=16,pt=0,l=0,sg=0:
Signing backend: ATSHA204
SHA256: 064A0459AAB0F53006E4E0648F9F547E24E39CDEF29299DE10FB759CD49CD6AE
Transmittng nonce
Skipping security for command 3 type 17
send: 32-32-0-0 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:064A0459AAB0F53006E4E0648F9F547E24E39CDEF29299DE10
Signature in message: 01E1A03B9429A6DBFF20E6D19D1E68C07E7CC238E3EC7893
Message to process: 00200E01020030
Current nonce: 064A0459AAB0F53006E4E0648F9F547E24E39CDEF29299DE10AAAAAAAAAAAAAA
HMAC: C1E1A03B9429A6DBFF20E6D19D1E68C07E7CC238E3EC78930184BD18F0823FF6
Signature OK
read: 0-0-32 s=0,c=1,t=2,pt=0,l=1,sg=0:0
Skipping security for command 3 type 16
read: 0-0-32 s=0,c=3,t=16,pt=0,l=0,sg=0:
Signing backend: ATSHA204
SHA256: 0D27D0A1761710382B1527AB510AAFBDF7E965AD4453E1451085252F4C422575
Transmittng nonce
Skipping security for command 3 type 17
send: 32-32-0-0 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:0D27D0A1761710382B1527AB510AAFBDF7E965AD4453E14510
Signature in message: 01BB1C2ABEF5EDB609FC783D2D4068632EA4CFFB49AE2C06
Message to process: 00200E01180038
Current nonce: 0D27D0A1761710382B1527AB510AAFBDF7E965AD4453E14510AAAAAAAAAAAAAA
HMAC: 00BB1C2ABEF5EDB609FC783D2D4068632EA4CFFB49AE2C06F614377BE7576BEC
Signature OK
read: 0-0-32 s=0,c=1,t=24,pt=0,l=1,sg=0:8

TEST 6

• Node is using soft signing, GW ATSHA204 signing
• Node and gateway on development branch
• Controller has time delays between time response send and state message

RESULT:

• As expected from the tests I did yesterday this test failed

Log from node

Starting sensor (RNNNAA, 2.0.0-beta)
Radio init successful.
Signing required
Skipping security for command 3 type 15
send: 32-32-0-0 s=255,c=3,t=15,pt=0,l=2,sg=0,st=ok:


Waiting for GW to send signing preferences...
Skipping security for command 3 type 15
read: 0-0-32 s=255,c=3,t=15,pt=0,l=2,sg=0:


Mark node 0 as one that require signed messages
Mark node 0 as one that do not require whitelisting
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:21F62EF9ADA09F07E5AB18EFA404E54CB1504EE3DA5FF1516E
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 2000560011FF322E302E302D62657461
Current nonce: 21F62EF9ADA09F07E5AB18EFA404E54CB1504EE3DA5FF1516EAAAAAAAAAAAAAA
HMAC: 1F7E4DF2B93FF4A998032FB88764F4027068F54496697E385F7E1278F3BD7BC8
Signature in message: 017E4DF2B93FF4A998032FB88764F4
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=0,t=17,pt=0,l=10,sg=1,st=ok:2.0.0-beta
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:42C03767A6A847595911A4ABADCE7129FEC4AC76952DDAEAD5
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 20000E2306FF00
Current nonce: 42C03767A6A847595911A4ABADCE7129FEC4AC76952DDAEAD5AAAAAAAAAAAAAA
HMAC: 4067930A19F2FF7ECDFB2442F8F9475BA30AF732AA5469A49F18D32ABF89D341
Signature in message: 0167930A19F2FF7ECDFB2442F8F9475BA30AF732AA5469A4
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=6,pt=1,l=1,sg=1,st=ok:0
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:BB9F341EBAD0551B8541AF7A7274CBE08EAE92E6914D64CF21
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 20008E030BFF53656E736562656E646572204D6963726F
Current nonce: BB9F341EBAD0551B8541AF7A7274CBE08EAE92E6914D64CF21AAAAAAAAAAAAAA
HMAC: 32623A195B988A45DD84948CD3D037D5F1A2C30570FC0667DEAE2C1A5F6E3870
Signature in message: 01623A195B988A45
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=11,pt=0,l=17,sg=1,st=ok:Sensebender Micro
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:797BDE0D89EE433BD1105F135F7BC4117889EC9164CC7440B6
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 20001E030CFF312E35
Current nonce: 797BDE0D89EE433BD1105F135F7BC4117889EC9164CC7440B6AAAAAAAAAAAAAA
HMAC: 4014EF97E0847D1320268E43F84DD28DE1B30700DBCC2F3D73E55BE76C86A865
Signature in message: 0114EF97E0847D1320268E43F84DD28DE1B30700DBCC
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=12,pt=0,l=3,sg=1,st=ok:1.5
Skipping security for command 3 type 16
send: 32-32-0-0 s=0,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:6928BF0F14662D30151049D54DC559D9980BDC58D05E4FCC11
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 200006001F00
Current nonce: 6928BF0F14662D30151049D54DC559D9980BDC58D05E4FCC11AAAAAAAAAAAAAA
HMAC: FB7B393036440F4EE838209F596F20A779319E4EA41E775D7B49A118AD405B61
Signature in message: 017B393036440F4EE838209F596F20A779319E4EA41E775D7B
Message signed
Message to send has been signed
send: 32-32-0-0 s=0,c=0,t=31,pt=0,l=0,sg=1,st=ok:
Init complete, id=32, parent=0, distance=1
------------- Start request time ------------
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:F1F6E026C9E12A1482F9E0629B219C299702775062CAE96EFC
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204
Message to process: 2000060301FF
Current nonce: F1F6E026C9E12A1482F9E0629B219C299702775062CAE96EFCAAAAAAAAAAAAAA
HMAC: B3F8B969384698B445CC9B94A3F9D632B2BC00282376066306277239A8781164
Signature in message: 01F8B969384698B445CC9B94A3F9D632B2BC00282376066306
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=1,pt=0,l=0,sg=1,st=ok:
Skipping security for command 3 type 16
read: 0-0-32 s=255,c=3,t=16,pt=0,l=0,sg=0:
Signing backend: ATSHA204
SHA256: BEA0F900BC32AC08474C32CE30CF7FD09424EE6FD7F56493DE6A79995E23E3F3
Transmittng nonce
Skipping security for command 3 type 17
send: 32-32-0-0 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:BEA0F900BC32AC08474C32CE30CF7FD09424EE6FD7F56493DE
Skipping security for command 3 type 16
read: 0-0-32 s=0,c=3,t=16,pt=0,l=0,sg=0:
Signing backend: ATSHA204
SHA256: 93D42A3EB88FECBA7026EA0CA7B96D4CEEF9CC84238EF7628AC1C6133C3657F5
Transmittng nonce
Skipping security for command 3 type 17
send: 32-32-0-0 s=255,c=3,t=17,pt=6,l=25,sg=0,st=fail:93D42A3EB88FECBA7026EA0CA7B96D4CEEF9CC84238EF7628A
Skipping security for command 3 type 16
read: 0-0-32 s=0,c=3,t=16,pt=0,l=0,sg=0:
Signing backend: ATSHA204
SHA256: C8C7D4569B16DD09FB5BAFB89FB78FA51E5BF8FEF98ED1F9764E547AE3B8B4BF
Transmittng nonce
Skipping security for command 3 type 17
send: 32-32-0-0 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:C8C7D4569B16DD09FB5BAFB89FB78FA51E5BF8FEF98ED1F976
Signature in message: 0126AF027E257738CFD55BE17BEDEAA3E525ED70ABB279D8
Message to process: 00200E01180038
Current nonce: C8C7D4569B16DD09FB5BAFB89FB78FA51E5BF8FEF98ED1F976AAAAAAAAAAAAAA
HMAC: 3F7E76453D012BADF96D39903092EB63E39B4C6A9DB91307F18E79BB50D58446
Signature bad: 017E76453D012BADF96D39903092EB63E39B4C6A9DB91307
Signature verification failed!
verify fail
No active verification session
Signature verification failed!

[Anticimex]

@tomkxy When you use soft signing, have you personalized that node with the same HMAC key? Soft signing on development stores this in EEPROM. It has to match what the other node has in the ATSHA204.

[tomkxy]

@Anticimex said:

@tomkxy When you use soft signing, have you personalized that node with the same HMAC key? Soft signing on development stores this in EEPROM. It has to match what the other node has in the ATSHA204.

Yes, while I was writing this occurred to me. That's the reason why I will repeat that test.

[Anticimex]

@tomkxy Ok cool. Thanks a LOT for your testing. From what I can see, you end up with something totally functional (for atsha at least)?
No additional delays, signing works (hopefully quicker), and node and gw can exchange signed messages without collisions/dropped messages due to sign fail, etc?

[tomkxy]

@Anticimex Ok. I repeated the the soft signing tests: Both, gateway and node on soft signing works.
Putting node on ATSHA204 signing while gateway is still on soft signing fails.

Apart from that issue, the implementation seems to work and improves obviously on the timing issue I had.

[tomkxy]

So, I repeated the test again, if GW and node are on soft sign it works. If I put either GW or node on soft sign, while the other is using ATSHA204, signing fails
To verify my setup I switched to development branch. There I could run the node on soft signing while the GW is using ATSHA204.

[Anticimex]

@tomkxy Hm, ok, so with the updates from PR, soft and atsha signing are not compatible? I need to check into that.
Out of curiosity, when you checked from development branch, was the ATSHA node using the code from the PR or was it also from development branch? Just so I know if the issue is in the soft signing implementation or both backends.

[tomkxy]

@Anticimex said:

@tomkxy Hm, ok, so with the updates from PR, soft and atsha signing are not compatible? I need to check into that.
Out of curiosity, when you checked from development branch, was the ATSHA node using the code from the PR or was it also from development branch? Just so I know if the issue is in the soft signing implementation or both backends.

I ran the test with node and gateway on PR code:
One test both on soft signing -> ok
One test node on soft signing, GW on ATSH204 -> failed

Then I repeated with both node and GW on development branch:

• node soft sign, GW on ATSHA204 -> OK

[Anticimex]

@tomkxy I think I found the problem. Mistake by me.
Try to change the following two lines (106 & 107) in MySigningAtsha204Soft.cpp:
memset(_signing_current_inbound_nonce, 0x00, NONCE_NUMIN_SIZE_PASSTHROUGH);
memset(_signing_current_outbound_nonce, 0x00, NONCE_NUMIN_SIZE_PASSTHROUGH);
to
memset(_signing_current_inbound_nonce, 0xAA, 32);
memset(_signing_current_outbound_nonce, 0xAA, 32);

[tomkxy]

@Anticimex said:

@tomkxy I think I found the problem. Mistake by me.
Try to change the following two lines (106 & 107) in MySigningAtsha204Soft.cpp:
memset(_signing_current_inbound_nonce, 0x00, NONCE_NUMIN_SIZE_PASSTHROUGH);
memset(_signing_current_outbound_nonce, 0x00, NONCE_NUMIN_SIZE_PASSTHROUGH);
to
memset(_signing_current_inbound_nonce, 0xAA, 32);
memset(_signing_current_outbound_nonce, 0xAA, 32);

I made the changes. Still not working.

[Anticimex]

@tomkxy Hm. I have rewritten the code to be easier to read. Could you please clean out the changes from my PR (restore to "pristine" development) and then reapply the PR from github?
If possible, also include the verbose logs from both ends so that we can confirm that they agree upon which nonce to use for a message.

[tomkxy]

@Anticimex said:

@tomkxy Hm. I have rewritten the code to be easier to read. Could you please clean out the changes from my PR (restore to "pristine" development) and then reapply the PR from github?
If possible, also include the verbose logs from both ends so that we can confirm that they agree upon which nonce to use for a message.

I cannot promise that I am able to do that today.

[Anticimex]

@tomkxy That's ok, No big rush on this. I suspect it is just a matter of the soft and atsha backends are not in agreement on the nonce data. I have not changed the algorithms so I would not expect them to be incompatible.

[tomkxy]

@Anticimex said:

@tomkxy That's ok, No big rush on this. I suspect it is just a matter of the soft and atsha backends are not in agreement on the nonce data. I have not changed the algorithms so I would not expect them to be incompatible.

Can I use the same pull request? I just fetched this one (https://github.com/mysensors/Arduino/pull/454)

OK?

[Anticimex]

@tomkxy yes, just make sure it applies cleanly. I forced pushed some updates.

[tomkxy]

@Anticimex said:

@tomkxy yes, just make sure it applies cleanly. I forced pushed some updates.

I sent you a chat message

[Anticimex]

@tomkxy So I noticed. Let's iron out the details in the chat, and report here when we sort it for documentation purposes.

[tomkxy]

Here are the log files. They are not in sync from the beginning. Further there re message from a node 27 which can be ignored. Best is probably to work from the end.

Node log

Starting sensor (RNNNAS, 2.0.0-beta)
Radio init successful.
Signing required
Skipping security for command 3 type 15
send: 32-32-0-0 s=255,c=3,t=15,pt=0,l=2,sg=0,st=ok:


Waiting for GW to send signing preferences...
Skipping security for command 3 type 15
read: 0-0-32 s=255,c=3,t=15,pt=0,l=2,sg=0:


Mark node 0 as one that require signed messages
Mark node 0 as one that do not require whitelisting
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:F0E3953E5E27A57274D53B6F0B2C4098EBD0F6A84345DE7135
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 2000560011FF322E302E302D62657461
Current nonce: F0E3953E5E27A57274D53B6F0B2C4098EBD0F6A84345DE7135AAAAAAAAAAAAAA
HMAC: DC73D1128E9B00E6E0FFA12AE46CBBD6BE0F3103FDFDE2D718A52AC530A852F9
Signature in message: 0173D1128E9B00E6E0FFA12AE46CBB
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=0,t=17,pt=0,l=10,sg=1,st=ok:2.0.0-beta
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:E574F30C89052CFEA25ACB6D9B3B4E8CA0D462DF4770ECF72F
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 20000E2306FF00
Current nonce: E574F30C89052CFEA25ACB6D9B3B4E8CA0D462DF4770ECF72FAAAAAAAAAAAAAA
HMAC: 556E870FC4662534A18B29FB7A48440B7C745E15FF82EA34E806F9C372B6FDA9
Signature in message: 016E870FC4662534A18B29FB7A48440B7C745E15FF82EA34
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=6,pt=1,l=1,sg=1,st=ok:0
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:10C33355BD231F7BB5E53E7E39372DE1C3053161AE04D74494
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 20008E030BFF53656E736562656E646572204D6963726F
Current nonce: 10C33355BD231F7BB5E53E7E39372DE1C3053161AE04D74494AAAAAAAAAAAAAA
HMAC: F272ECC9E1B27FF3C089905712EDF1793D146865CE2AF9252D27FAFF953BA64F
Signature in message: 0172ECC9E1B27FF3
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=11,pt=0,l=17,sg=1,st=ok:Sensebender Micro
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:3B91B8117E813E6F0E12221791A78309559E5052097A420E8A
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 20001E030CFF312E35
Current nonce: 3B91B8117E813E6F0E12221791A78309559E5052097A420E8AAAAAAAAAAAAAAA
HMAC: 23E348148A34E8BE86788E5AA5F45F8F675089068DA52BC6C4C27D0B8DCA70C3
Signature in message: 01E348148A34E8BE86788E5AA5F45F8F675089068DA5
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=12,pt=0,l=3,sg=1,st=ok:1.5
Skipping security for command 3 type 16
send: 32-32-0-0 s=0,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:694B1F7903CB8A6854DAF8509AA451207AD040D71966A3453D
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 200006001F00
Current nonce: 694B1F7903CB8A6854DAF8509AA451207AD040D71966A3453DAAAAAAAAAAAAAA
HMAC: 6013C5AA4FDD7E2F61EAA2C3F2716BCEEFB56292BA66BC98A43517E458EF235B
Signature in message: 0113C5AA4FDD7E2F61EAA2C3F2716BCEEFB56292BA66BC98A4
Message signed
Message to send has been signed
send: 32-32-0-0 s=0,c=0,t=31,pt=0,l=0,sg=1,st=ok:
Init complete, id=32, parent=0, distance=1
------------- Start request time ------------
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:13F0B25E5D9A117DA1146AFA7494C90FA33FA03B128B0CE3E1
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 2000060301FF
Current nonce: 13F0B25E5D9A117DA1146AFA7494C90FA33FA03B128B0CE3E1AAAAAAAAAAAAAA
HMAC: 5F71BF42F9C80CC00B5319226D836566CD4F95123E96258FF8E2E3400863547E
Signature in message: 0171BF42F9C80CC00B5319226D836566CD4F95123E96258FF8
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=1,pt=0,l=0,sg=1,st=ok:
------------- End request time ------------
------------- Start request time ------------
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:8FBD6C07C7957826D2BAF13CDD7A82D8082180FD4F0796F6B4
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 2000060301FF
Current nonce: 8FBD6C07C7957826D2BAF13CDD7A82D8082180FD4F0796F6B4AAAAAAAAAAAAAA
HMAC: 6FAC958E93696F29B508B534322FC0237EB1740405F2A7AA2A518FBF4883896D
Signature in message: 01AC958E93696F29B508B534322FC0237EB1740405F2A7AA2A
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=1,pt=0,l=0,sg=1,st=ok:
------------- End request time ------------
------------- Start request time ------------
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:6BB69A71C65A24D7077B9B2A2E65D51B3861A56CF777BBD6B6
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 2000060301FF
Current nonce: 6BB69A71C65A24D7077B9B2A2E65D51B3861A56CF777BBD6B6AAAAAAAAAAAAAA
HMAC: 3E2DE76DD7349510C9CAE6F072875D7D7C380BBDD00C65339BF25898F44A180B
Signature in message: 012DE76DD7349510C9CAE6F072875D7D7C380BBDD00C65339B
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=1,pt=0,l=0,sg=1,st=ok:
------------- End request time ------------
------------- Start request time ------------
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:B7CD5773148E8916C98B5BB16265F17811F8091A560A3535EB
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 2000060301FF
Current nonce: B7CD5773148E8916C98B5BB16265F17811F8091A560A3535EBAAAAAAAAAAAAAA
HMAC: 46959641C93642F85E13499948DC33F1CE3B1B0DE5D8DEC8F5D04ECBA2A28552
Signature in message: 01959641C93642F85E13499948DC33F1CE3B1B0DE5D8DEC8F5
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=1,pt=0,l=0,sg=1,st=ok:
------------- End request time ------------
------------- Start request time ------------
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:43AADEA58D5CC9AF0A58FE4A763CEE560CB751BCF31BAD7F4C
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 2000060301FF
Current nonce: 43AADEA58D5CC9AF0A58FE4A763CEE560CB751BCF31BAD7F4CAAAAAAAAAAAAAA
HMAC: 1217705F14F7482ACEEC510ADD5EB2CBB329B3FA475486182644D5EC98DDB619
Signature in message: 0117705F14F7482ACEEC510ADD5EB2CBB329B3FA4754861826
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=1,pt=0,l=0,sg=1,st=ok:
------------- End request time ------------
------------- Start request time ------------
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:90E1C960135A6C130C95D8DCDA63C583905F58BC0C0AC6734C
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 2000060301FF
Current nonce: 90E1C960135A6C130C95D8DCDA63C583905F58BC0C0AC6734CAAAAAAAAAAAAAA
HMAC: 5DE257A17035F53D20CE18F57BF0E0E60142F56690BB8BB9F4184632241E2015
Signature in message: 01E257A17035F53D20CE18F57BF0E0E60142F56690BB8BB9F4
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=1,pt=0,l=0,sg=1,st=ok:
------------- End request time ------------
------------- Start request time ------------
Skipping security for command 3 type 16
send: 32-32-0-0 s=255,c=3,t=16,pt=0,l=0,sg=0,st=ok:
Nonce requested from 0. Waiting...
Skipping security for command 3 type 17
read: 0-0-32 s=255,c=3,t=17,pt=6,l=25,sg=0:5FB2B52B80BA2BD2B7F657B3754594C84B14811B6067EEB626
Nonce received from 0. Proceeding with signing...
Signing backend: ATSHA204Soft
Message to process: 2000060301FF
Current nonce: 5FB2B52B80BA2BD2B7F657B3754594C84B14811B6067EEB626AAAAAAAAAAAAAA
HMAC: 00AE0409E50F471F7B4154A4492D72FA382EEA40257DD408D2EB9E1B012A35EF
Signature in message: 01AE0409E50F471F7B4154A4492D72FA382EEA40257DD408D2
Message signed
Message to send has been signed
send: 32-32-0-0 s=255,c=3,t=1,pt=0,l=0,sg=1,st=ok:

Log file from gateway:

0;255;3;0;9;Starting gateway (RNNGAA, 2.0.0-beta)
0;255;3;0;9;Radio init successful.
0;255;3;0;9;Init complete, id=0, parent=0, distance=0
0;255;3;0;9;Attempting MQTT connection...
0;255;3;0;9;MQTT connected
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: B44451C64C562F11BDCF41F7F3EEF39816265188B34FD45E96216B85148A12AA
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:B44451C64C562F11BDCF41F7F3EEF39816265188B34FD45E96
0;255;3;0;9;Signature in message: 0191F99D82163BDAF73FFD91B6984D59A5F564BF45ECBBABCE
0;255;3;0;9;Message to process: 2000060301FF
0;255;3;0;9;Current nonce: B44451C64C562F11BDCF41F7F3EEF39816265188B34FD45E96AAAAAAAAAAAAAA
0;255;3;0;9;HMAC: EB8162E2FCAD9359B19B383A711A5E64A964A25F965162BF74BBFB4EB59836E2
0;255;3;0;9;Signature bad: 018162E2FCAD9359B19B383A711A5E64A964A25F965162BF74
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;read: 27-27-0 s=2,c=1,t=1,pt=7,l=5,sg=0:62.49
0;255;3;0;9;Sending message on topic: GW1_out/27/2/1/0/1
0;255;3;0;9;read: 27-27-0 s=1,c=1,t=0,pt=7,l=5,sg=0:34.11
0;255;3;0;9;Sending message on topic: GW1_out/27/1/1/0/0
0;255;3;0;9;read: 27-27-0 s=0,c=1,t=4,pt=7,l=5,sg=0:1020.15
0;255;3;0;9;Sending message on topic: GW1_out/27/0/1/0/4
0;255;3;0;9;read: 27-27-0 s=0,c=1,t=5,pt=0,l=6,sg=0:stable
0;255;3;0;9;Sending message on topic: GW1_out/27/0/1/0/5
0;255;3;0;9;read: 27-27-0 s=10,c=1,t=38,pt=7,l=5,sg=0:4.123
0;255;3;0;9;Sending message on topic: GW1_out/27/10/1/0/38
0;255;3;0;9;read: 27-27-0 s=10,c=1,t=39,pt=7,l=5,sg=0:0.000000
0;255;3;0;9;Sending message on topic: GW1_out/27/10/1/0/39
0;255;3;0;9;read: 27-27-0 s=11,c=1,t=38,pt=7,l=5,sg=0:9.978
0;255;3;0;9;Sending message on topic: GW1_out/27/11/1/0/38
0;255;3;0;9;read: 27-27-0 s=255,c=3,t=0,pt=1,l=1,sg=0:88
0;255;3;0;9;Sending message on topic: GW1_out/27/255/3/0/0
0;255;3;0;9;read: 27-27-0 s=13,c=1,t=8,pt=7,l=5,sg=0:0.40
0;255;3;0;9;Sending message on topic: GW1_out/27/13/1/0/8
0;255;3;0;9;read: 27-27-0 s=13,c=1,t=9,pt=7,l=5,sg=0:0.60
0;255;3;0;9;Sending message on topic: GW1_out/27/13/1/0/9
0;255;3;0;9;read: 27-27-0 s=12,c=1,t=10,pt=7,l=5,sg=0:328.68
0;255;3;0;9;Sending message on topic: GW1_out/27/12/1/0/10
0;255;3;0;9;read: 27-27-0 s=12,c=1,t=24,pt=7,l=5,sg=0:36.80
0;255;3;0;9;Sending message on topic: GW1_out/27/12/1/0/24
0;255;3;0;9;read: 27-27-0 s=14,c=1,t=6,pt=7,l=5,sg=0:0.00
0;255;3;0;9;Sending message on topic: GW1_out/27/14/1/0/6
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 9BEBE9A04F339CE85808EBF1B5E8BC7BD611CC3B5C0A638DF2A548B398BF059E
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:9BEBE9A04F339CE85808EBF1B5E8BC7BD611CC3B5C0A638DF2
0;255;3;0;9;Signature in message: 012C3605DF4F03AD69833FCC101EA1BF0E5750483F4E2107F6
0;255;3;0;9;Message to process: 2000060301FF
0;255;3;0;9;Current nonce: 9BEBE9A04F339CE85808EBF1B5E8BC7BD611CC3B5C0A638DF2AAAAAAAAAAAAAA
0;255;3;0;9;HMAC: 681C6D87947BC2574D48FFCAC370BECD30789EAEB7C2BFBAD562B2ED7DCAE10F
0;255;3;0;9;Signature bad: 011C6D87947BC2574D48FFCAC370BECD30789EAEB7C2BFBAD5
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;Skipping security for command 3 type 15
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=15,pt=0,l=2,sg=0:


0;255;3;0;9;Mark node 32 as one that require signed messages
0;255;3;0;9;Mark node 32 as one that do not require whitelisting
0;255;3;0;9;Informing node 32 that we require signatures
0;255;3;0;9;Informing node 32 that we do not require whitelisting
0;255;3;0;9;Skipping security for command 3 type 15
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=15,pt=0,l=2,sg=0,st=ok:


0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: F0E3953E5E27A57274D53B6F0B2C4098EBD0F6A84345DE7135D3A4AEC3E13960
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:F0E3953E5E27A57274D53B6F0B2C4098EBD0F6A84345DE7135
0;255;3;0;9;Signature in message: 0173D1128E9B00E6E0FFA12AE46CBB
0;255;3;0;9;Message to process: 2000560011FF322E302E302D62657461
0;255;3;0;9;Current nonce: F0E3953E5E27A57274D53B6F0B2C4098EBD0F6A84345DE7135AAAAAAAAAAAAAA
0;255;3;0;9;HMAC: CBC7FC088614695AD92A5A4A32CA832C6D00041CF63D1AF78F353FD6E0D9D949
0;255;3;0;9;Signature bad: 01C7FC088614695AD92A5A4A32CA83
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: E574F30C89052CFEA25ACB6D9B3B4E8CA0D462DF4770ECF72FB75DED8D5F68BC
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:E574F30C89052CFEA25ACB6D9B3B4E8CA0D462DF4770ECF72F
0;255;3;0;9;Signature in message: 016E870FC4662534A18B29FB7A48440B7C745E15FF82EA34
0;255;3;0;9;Message to process: 20000E2306FF00
0;255;3;0;9;Current nonce: E574F30C89052CFEA25ACB6D9B3B4E8CA0D462DF4770ECF72FAAAAAAAAAAAAAA
0;255;3;0;9;HMAC: 5E2D30821345709074EB96B09CC0C7408E1291AC5C921432DD83A29919734767
0;255;3;0;9;Signature bad: 012D30821345709074EB96B09CC0C7408E1291AC5C921432
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 10C33355BD231F7BB5E53E7E39372DE1C3053161AE04D744948C093BFA5776C8
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:10C33355BD231F7BB5E53E7E39372DE1C3053161AE04D74494
0;255;3;0;9;Signature in message: 0172ECC9E1B27FF3
0;255;3;0;9;Message to process: 20008E030BFF53656E736562656E646572204D6963726F
0;255;3;0;9;Current nonce: 10C33355BD231F7BB5E53E7E39372DE1C3053161AE04D74494AAAAAAAAAAAAAA
0;255;3;0;9;HMAC: 82CCF6912389FCE5896B4867B82879414D80FE3FBAC1C6365E0B6303F7DADB56
0;255;3;0;9;Signature bad: 01CCF6912389FCE5
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 3B91B8117E813E6F0E12221791A78309559E5052097A420E8A3AB9EDED6F5D56
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:3B91B8117E813E6F0E12221791A78309559E5052097A420E8A
0;255;3;0;9;Signature in message: 01E348148A34E8BE86788E5AA5F45F8F675089068DA5
0;255;3;0;9;Message to process: 20001E030CFF312E35
0;255;3;0;9;Current nonce: 3B91B8117E813E6F0E12221791A78309559E5052097A420E8AAAAAAAAAAAAAAA
0;255;3;0;9;HMAC: ACFBD53ADA240C2FF69FF474887A750BEC719180D3A30B132AF241E94D8CF15B
0;255;3;0;9;Signature bad: 01FBD53ADA240C2FF69FF474887A750BEC719180D3A3
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=0,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 694B1F7903CB8A6854DAF8509AA451207AD040D71966A3453D7D5772649E35E9
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:694B1F7903CB8A6854DAF8509AA451207AD040D71966A3453D
0;255;3;0;9;Signature in message: 0113C5AA4FDD7E2F61EAA2C3F2716BCEEFB56292BA66BC98A4
0;255;3;0;9;Message to process: 200006001F00
0;255;3;0;9;Current nonce: 694B1F7903CB8A6854DAF8509AA451207AD040D71966A3453DAAAAAAAAAAAAAA
0;255;3;0;9;HMAC: 786E3B4757AA9BA51BB69546A59AC2E07B4FD696E79A72BF4DBD14530CBDFB21
0;255;3;0;9;Signature bad: 016E3B4757AA9BA51BB69546A59AC2E07B4FD696E79A72BF4D
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 13F0B25E5D9A117DA1146AFA7494C90FA33FA03B128B0CE3E1ED939BDD46DD66
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:13F0B25E5D9A117DA1146AFA7494C90FA33FA03B128B0CE3E1
0;255;3;0;9;Signature in message: 0171BF42F9C80CC00B5319226D836566CD4F95123E96258FF8
0;255;3;0;9;Message to process: 2000060301FF
0;255;3;0;9;Current nonce: 13F0B25E5D9A117DA1146AFA7494C90FA33FA03B128B0CE3E1AAAAAAAAAAAAAA
0;255;3;0;9;HMAC: 7C9BD8227613765CC0A7D20E5C76396F6B380BB4D6A4199CDAB76C4D5CFF5C43
0;255;3;0;9;Signature bad: 019BD8227613765CC0A7D20E5C76396F6B380BB4D6A4199CDA
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;read: 27-27-0 s=13,c=1,t=8,pt=7,l=5,sg=0:0.13
0;255;3;0;9;Sending message on topic: GW1_out/27/13/1/0/8
0;255;3;0;9;read: 27-27-0 s=13,c=1,t=9,pt=7,l=5,sg=0:0.40
0;255;3;0;9;Sending message on topic: GW1_out/27/13/1/0/9
0;255;3;0;9;read: 27-27-0 s=12,c=1,t=10,pt=7,l=5,sg=0:225.00
0;255;3;0;9;Sending message on topic: GW1_out/27/12/1/0/10
0;255;3;0;9;read: 27-27-0 s=12,c=1,t=24,pt=7,l=5,sg=0:0.02
0;255;3;0;9;Sending message on topic: GW1_out/27/12/1/0/24
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 8FBD6C07C7957826D2BAF13CDD7A82D8082180FD4F0796F6B4E49547312D56B7
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:8FBD6C07C7957826D2BAF13CDD7A82D8082180FD4F0796F6B4
0;255;3;0;9;Signature in message: 01AC958E93696F29B508B534322FC0237EB1740405F2A7AA2A
0;255;3;0;9;Message to process: 2000060301FF
0;255;3;0;9;Current nonce: 8FBD6C07C7957826D2BAF13CDD7A82D8082180FD4F0796F6B4AAAAAAAAAAAAAA
0;255;3;0;9;HMAC: 2C52B5D52BDA0030F2BC63D2CE6EB6CF7ED83AB9F35DCEA61147FB3429B03170
0;255;3;0;9;Signature bad: 0152B5D52BDA0030F2BC63D2CE6EB6CF7ED83AB9F35DCEA611
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 26-26-0 s=1,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 53FB5496D3358338CE2D5082FAC5D043DE6D4E0D607275D2F3908F0F1AF8CB73
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-26-26 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:53FB5496D3358338CE2D5082FAC5D043DE6D4E0D607275D2F3
0;255;3;0;9;Signature in message: 012C20F0DC9CF89B84455FA90271B4823E60DF9D
0;255;3;0;9;Message to process: 1A002EE100014879D04101
0;255;3;0;9;Current nonce: 53FB5496D3358338CE2D5082FAC5D043DE6D4E0D607275D2F3AAAAAAAAAAAAAA
0;255;3;0;9;HMAC: 1D593C273D7167F9756DCA5CE4AF8005D7E5B8D6B95CF2C3B0C10A839E057FC3
0;255;3;0;9;Signature bad: 01593C273D7167F9756DCA5CE4AF8005D7E5B8D6
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 26-26-0 s=2,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 3081C0AF2996E0041CC85171727DB5F96A8201CF0BCC0D92FE3CC33C2A7B9705
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-26-26 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:3081C0AF2996E0041CC85171727DB5F96A8201CF0BCC0D92FE
0;255;3;0;9;Signature in message: 01395A6873A0741CFD612BEC59D9E865888C6C29
0;255;3;0;9;Message to process: 1A002EE10102905B3A4201
0;255;3;0;9;Current nonce: 3081C0AF2996E0041CC85171727DB5F96A8201CF0BCC0D92FEAAAAAAAAAAAAAA
0;255;3;0;9;HMAC: 137DD0BB67606DDBF1F16854BFE720BB29C6ED1BFDD421430688DFC08F0813AF
0;255;3;0;9;Signature bad: 017DD0BB67606DDBF1F16854BFE720BB29C6ED1B
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 6BB69A71C65A24D7077B9B2A2E65D51B3861A56CF777BBD6B6B626B2A3942FAF
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:6BB69A71C65A24D7077B9B2A2E65D51B3861A56CF777BBD6B6
0;255;3;0;9;Signature in message: 012DE76DD7349510C9CAE6F072875D7D7C380BBDD00C65339B
0;255;3;0;9;Message to process: 2000060301FF
0;255;3;0;9;Current nonce: 6BB69A71C65A24D7077B9B2A2E65D51B3861A56CF777BBD6B6AAAAAAAAAAAAAA
0;255;3;0;9;HMAC: A7FC0A4823BBE2F65EFC0F872743D808BB3DE432CCDEED33353C46B6D50736DD
0;255;3;0;9;Signature bad: 01FC0A4823BBE2F65EFC0F872743D808BB3DE432CCDEED3335
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;read: 22-22-0 s=3,c=1,t=0,pt=7,l=5,sg=0:31.0
0;255;3;0;9;Sending message on topic: GW1_out/22/3/1/0/0
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: B7CD5773148E8916C98B5BB16265F17811F8091A560A3535EB6113A76207EE59
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:B7CD5773148E8916C98B5BB16265F17811F8091A560A3535EB
0;255;3;0;9;Signature in message: 01959641C93642F85E13499948DC33F1CE3B1B0DE5D8DEC8F5
0;255;3;0;9;Message to process: 2000060301FF
0;255;3;0;9;Current nonce: B7CD5773148E8916C98B5BB16265F17811F8091A560A3535EBAAAAAAAAAAAAAA
0;255;3;0;9;HMAC: 218006AFDB5D1A909B39808D0F79E620974D2B7A291A929FD4524C0D3E5BEF9E
0;255;3;0;9;Signature bad: 018006AFDB5D1A909B39808D0F79E620974D2B7A291A929FD4
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail
0;255;3;0;9;Skipping security for command 3 type 16
0;255;3;0;9;read: 32-32-0 s=255,c=3,t=16,pt=0,l=0,sg=0:
0;255;3;0;9;Signing backend: ATSHA204
0;255;3;0;9;SHA256: 43AADEA58D5CC9AF0A58FE4A763CEE560CB751BCF31BAD7F4CCAEEC0925C60AA
0;255;3;0;9;Transmittng nonce
0;255;3;0;9;Skipping security for command 3 type 17
0;255;3;0;9;send: 0-0-32-32 s=255,c=3,t=17,pt=6,l=25,sg=0,st=ok:43AADEA58D5CC9AF0A58FE4A763CEE560CB751BCF31BAD7F4C
0;255;3;0;9;Signature in message: 0117705F14F7482ACEEC510ADD5EB2CBB329B3FA4754861826
0;255;3;0;9;Message to process: 2000060301FF
0;255;3;0;9;Current nonce: 43AADEA58D5CC9AF0A58FE4A763CEE560CB751BCF31BAD7F4CAAAAAAAAAAAAAA
0;255;3;0;9;HMAC: DD7AADA9C207653FF0E5184E006CCB4707837275511EC2136773AEFE80C89AB9
0;255;3;0;9;Signature bad: 017AADA9C207653FF0E5184E006CCB4707837275511EC21367
0;255;3;0;9;Signature verification failed!
0;255;3;0;9;verify fail

[Anticimex]

I believe we sorted this through chat/github. Thanks for finding the issue and helping out with testing!

[tomkxy]

@anticimex Thanks to your excellent working, it is working now.