search

bbindreiter / node-red-contrib-alexa-remote2-applestrudel

Node-Red Nodes for interacting with Alexa
https://flows.nodered.org/node/node-red-contrib-alexa-remote2-applestrudel
MIT License
77 stars 21 forks source link

My HTTP2-PUSH connection keeps reinitialising - why? #205

Open danielbrunt57 opened 1 month ago

danielbrunt57 commented 1 month ago

I cannot figure out what I might have done wrong.

19 Oct 14:19:44 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Close: undefined: undefined
19 Oct 14:19:44 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Retry Connection in 25s
19 Oct 14:19:52 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Close: undefined: undefined
19 Oct 14:19:52 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Retry Connection in 60s
19 Oct 14:20:07 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Close: undefined: undefined
19 Oct 14:20:07 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Retry Connection in 45s
19 Oct 14:20:09 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Update access token ...
19 Oct 14:20:09 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Use host bob-dispatch-prod-na.amazon.com
19 Oct 14:20:10 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Initialization completed
19 Oct 14:20:12 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Update access token ...
19 Oct 14:20:12 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Use host bob-dispatch-prod-na.amazon.com
19 Oct 14:20:12 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Initialization completed
19 Oct 14:20:24 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Update access token ...
19 Oct 14:20:24 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Use host bob-dispatch-prod-na.amazon.com
19 Oct 14:20:24 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Initialization completed
19 Oct 14:20:25 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Update access token ...
19 Oct 14:20:25 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Use host bob-dispatch-prod-na.amazon.com
19 Oct 14:20:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Initialization completed
19 Oct 14:20:29 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Update access token ...
19 Oct 14:20:29 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Use host bob-dispatch-prod-na.amazon.com
19 Oct 14:20:29 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Initialization completed
19 Oct 14:20:35 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Close: undefined: undefined
19 Oct 14:20:35 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Retry Connection in 60s
danielbrunt57 commented 1 month ago

Additional logs:

19 Oct 15:46:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Get pushed activities ... 1 entries in queue (already running: false)
19 Oct 15:46:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No authentication check needed (time elapsed 313688)
19 Oct 15:46:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Sending Request with {"host":"www.amazon.ca","path":"/alexa-privacy/apd/rvh/customer-history-records-v2?startTime=1729377913792&endTime=1729464386278","method":"POST","timeout":10000,"headers":{"Accept-Language":"en-CA","anti-csrftoken-a2z":"hESksy1Y7lfmQlrjCKvkY3gJRoHpWBX2MyLgdF4tYrODAAAAAGcUNZoAAAAB","referer":"https://www.amazon.ca/alexa-privacy/apd/activity?disableGlobalNav=true&ref=activityHistory"}}  and data={"previousRequestToken": null}
19 Oct 15:46:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Response: {"customerHistoryRecords":[],"encodedRequestToken":null,"noDataFoundWithinTimeLimit":false,"lastRecordTimestamp":null,"voiceProfileAssociatedWithPerson":false}
19 Oct 15:46:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity data []
19 Oct 15:46:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity for device G2A1B505216600EE not found
19 Oct 15:46:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No activities from stored 1 entries found in queue (2)
19 Oct 15:46:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Reset expected activities
19 Oct 15:46:36 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Close: undefined: undefined
19 Oct 15:46:36 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Retry Connection in 15s
19 Oct 15:46:51 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Update access token ...
19 Oct 15:46:51 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Use host alexa.na.gateway.devices.a2z.com
19 Oct 15:46:52 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Initialization completed
danielbrunt57 commented 1 month ago

I just looked at debug logs now and I'm seeing push commands being received but zero activity on my Alexa Event node "On Device Activity".

21 Oct 05:24:03 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Send Ping
21 Oct 05:24:04 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Command PUSH_EQUALIZER_STATE_CHANGE: {
    "dopplerId": {
        "deviceSerialNumber": "G2A1B505216600EE",
        "deviceType": "A3RMGO6LYLH7YN"
    },
    "bass": 0,
    "midrange": 0,
    "treble": 0,
    "destinationUserId": "A1UZ93DGNU3F5L"
}
21 Oct 05:24:04 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Command PUSH_VOLUME_CHANGE: {
    "dopplerId": {
        "deviceSerialNumber": "G2A1B505216600EE",
        "deviceType": "A3RMGO6LYLH7YN"
    },
    "volumeSetting": 30,
    "isMuted": false,
    "destinationUserId": "A1UZ93DGNU3F5L"
}
21 Oct 05:24:05 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Command PUSH_EQUALIZER_STATE_CHANGE: {
    "dopplerId": {
        "deviceSerialNumber": "G091AA0805061S0N",
        "deviceType": "A2U21SRK4QGSE1"
    },
    "bass": 0,
    "midrange": 0,
    "treble": 0,
    "destinationUserId": "A1UZ93DGNU3F5L"
}
21 Oct 05:24:05 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Command PUSH_VOLUME_CHANGE: {
    "dopplerId": {
        "deviceSerialNumber": "G091AA0805061S0N",
        "deviceType": "A2U21SRK4QGSE1"
    },
    "volumeSetting": 7,
    "isMuted": false,
    "destinationUserId": "A1UZ93DGNU3F5L"
}
21 Oct 05:24:05 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Command PUSH_EQUALIZER_STATE_CHANGE: {
    "dopplerId": {
        "deviceSerialNumber": "G091AA08051216SA",
        "deviceType": "A2U21SRK4QGSE1"
    },
    "bass": 0,
    "midrange": 0,
    "treble": 0,
    "destinationUserId": "A1UZ93DGNU3F5L"
}
21 Oct 05:24:05 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Command PUSH_VOLUME_CHANGE: {
    "dopplerId": {
        "deviceSerialNumber": "G091AA08051216SA",
        "deviceType": "A2U21SRK4QGSE1"
    },
    "volumeSetting": 7,
    "isMuted": false,
    "destinationUserId": "A1UZ93DGNU3F5L"
}
21 Oct 05:24:19 - [debug] Flushing localfilesystem context scope 2e9d28adf92d0cd8:2dabc9c1.e88156
21 Oct 05:24:19 - [debug] Flushing localfilesystem context scope 1a7c5bf71cea2f7d:2dabc9c1.e88156

image

figorr commented 1 month ago

Hi Daniel,

Did you enable auto query activities to ON when you setup the Alexa account?

I think by default is OFF.

image Step 1 image this should be on - then reboot

Originally posted by @notenoughtech in https://github.com/bbindreiter/node-red-contrib-alexa-remote2-applestrudel/issues/188#issuecomment-2132070087

danielbrunt57 commented 1 month ago

Yes, that is enabled:

image

I've found that if I edit any flow and Deploy > Restart Flows it seems to break and I have to restart the Node-RED add-on to resume listening & processing. I just tested now asking office echo dot right "what time is it" and my flow is still working after having been idle for several hours:

image

I'm currently not seeing the Alexa-Remote HTTP2-PUSH: Close: undefined: undefined messages.
They seem to only occur after I've done Restart Flows? Which might indicate restart flows somehow breaks the previous HTTP2 connection that was established after a reboot? I'm just hazarding a programmer's SWAG...

danielbrunt57 commented 1 month ago

This all looks good:

22 Oct 00:55:10 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Get pushed activities ... 1 entries in queue (already running: false)
22 Oct 00:55:10 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No authentication check needed (time elapsed 465909)
22 Oct 00:55:10 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Sending Request with {"host":"www.amazon.ca","path":"/alexa-privacy/apd/rvh/customer-history-records-v2?startTime=1729583642305&endTime=1729670110512","method":"POST","timeout":10000,"headers":{"Accept-Language":"en-CA","anti-csrftoken-a2z":"hKxUAfaPOvv5r6Q9BZlKEZTGCY5jxdPC1gd05Iq3ilXtAAAAAGcXVOMAAAAB","referer":"https://www.amazon.ca/alexa-privacy/apd/activity?disableGlobalNav=true&ref=activityHistory"}}  and data={"previousRequestToken": null}
22 Oct 00:55:10 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Response: {"customerHistoryRecords":[],"encodedRequestToken":null,"noDataFoundWithinTimeLimit":false,"lastRecordTimestamp":null,"voiceProfileAssociatedWithPerson":false}
22 Oct 00:55:10 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity data []
22 Oct 00:55:10 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity for device G091AA0805061S0N not found
22 Oct 00:55:10 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No activities from stored 1 entries found in queue (1)
22 Oct 00:55:14 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Get pushed activities ... 1 entries in queue (already running: false)
22 Oct 00:55:14 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No authentication check needed (time elapsed 470118)
22 Oct 00:55:14 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Sending Request with {"host":"www.amazon.ca","path":"/alexa-privacy/apd/rvh/customer-history-records-v2?startTime=1729583642305&endTime=1729670114721","method":"POST","timeout":10000,"headers":{"Accept-Language":"en-CA","anti-csrftoken-a2z":"hKxUAfaPOvv5r6Q9BZlKEZTGCY5jxdPC1gd05Iq3ilXtAAAAAGcXVOMAAAAB","referer":"https://www.amazon.ca/alexa-privacy/apd/activity?disableGlobalNav=true&ref=activityHistory"}}  and data={"previousRequestToken": null}
22 Oct 00:55:14 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Response: {"customerHistoryRecords":[],"encodedRequestToken":null,"noDataFoundWithinTimeLimit":false,"lastRecordTimestamp":null,"voiceProfileAssociatedWithPerson":false}
22 Oct 00:55:14 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity data []
22 Oct 00:55:14 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity for device G091AA0805061S0N not found
22 Oct 00:55:14 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No activities from stored 1 entries found in queue (2)
22 Oct 00:55:14 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Reset expected activities
22 Oct 00:55:15 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Command PUSH_VOLUME_CHANGE: {
    "dopplerId": {
        "deviceSerialNumber": "G2A1B505216600EE",
        "deviceType": "A3RMGO6LYLH7YN"
    },
    "volumeSetting": 30,
    "isMuted": false,
    "destinationUserId": "A1UZ93DGNU3F5L"
}
22 Oct 00:55:15 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Simulate activity for G2A1B505216600EE with destinationUserId A1UZ93DGNU3F5L ... fetch in 3s
22 Oct 00:55:15 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Command PUSH_EQUALIZER_STATE_CHANGE: {
    "dopplerId": {
        "deviceSerialNumber": "G2A1B505216600EE",
        "deviceType": "A3RMGO6LYLH7YN"
    },
    "bass": 0,
    "midrange": 0,
    "treble": 0,
    "destinationUserId": "A1UZ93DGNU3F5L"
}
22 Oct 00:55:19 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Get pushed activities ... 1 entries in queue (already running: false)
22 Oct 00:55:19 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No authentication check needed (time elapsed 475343)
22 Oct 00:55:19 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Sending Request with {"host":"www.amazon.ca","path":"/alexa-privacy/apd/rvh/customer-history-records-v2?startTime=1729583655944&endTime=1729670119946","method":"POST","timeout":10000,"headers":{"Accept-Language":"en-CA","anti-csrftoken-a2z":"hKxUAfaPOvv5r6Q9BZlKEZTGCY5jxdPC1gd05Iq3ilXtAAAAAGcXVOMAAAAB","referer":"https://www.amazon.ca/alexa-privacy/apd/activity?disableGlobalNav=true&ref=activityHistory"}}  and data={"previousRequestToken": null}
22 Oct 00:55:20 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Response: {"customerHistoryRecords":[],"encodedRequestToken":null,"noDataFoundWithinTimeLimit":false,"lastRecordTimestamp":null,"voiceProfileAssociatedWithPerson":false}
22 Oct 00:55:20 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity data []
22 Oct 00:55:20 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity for device G2A1B505216600EE not found
22 Oct 00:55:20 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No activities from stored 1 entries found in queue (0)
22 Oct 00:55:24 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Get pushed activities ... 1 entries in queue (already running: false)
22 Oct 00:55:24 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No authentication check needed (time elapsed 479515)
22 Oct 00:55:24 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Sending Request with {"host":"www.amazon.ca","path":"/alexa-privacy/apd/rvh/customer-history-records-v2?startTime=1729583655944&endTime=1729670124118","method":"POST","timeout":10000,"headers":{"Accept-Language":"en-CA","anti-csrftoken-a2z":"hKxUAfaPOvv5r6Q9BZlKEZTGCY5jxdPC1gd05Iq3ilXtAAAAAGcXVOMAAAAB","referer":"https://www.amazon.ca/alexa-privacy/apd/activity?disableGlobalNav=true&ref=activityHistory"}}  and data={"previousRequestToken": null}
22 Oct 00:55:24 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Response: {"customerHistoryRecords":[],"encodedRequestToken":null,"noDataFoundWithinTimeLimit":false,"lastRecordTimestamp":null,"voiceProfileAssociatedWithPerson":false}
22 Oct 00:55:24 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity data []
22 Oct 00:55:24 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity for device G2A1B505216600EE not found
22 Oct 00:55:24 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No activities from stored 1 entries found in queue (1)
22 Oct 00:55:28 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Get pushed activities ... 1 entries in queue (already running: false)
22 Oct 00:55:28 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No authentication check needed (time elapsed 483716)
22 Oct 00:55:28 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Sending Request with {"host":"www.amazon.ca","path":"/alexa-privacy/apd/rvh/customer-history-records-v2?startTime=1729583655944&endTime=1729670128319","method":"POST","timeout":10000,"headers":{"Accept-Language":"en-CA","anti-csrftoken-a2z":"hKxUAfaPOvv5r6Q9BZlKEZTGCY5jxdPC1gd05Iq3ilXtAAAAAGcXVOMAAAAB","referer":"https://www.amazon.ca/alexa-privacy/apd/activity?disableGlobalNav=true&ref=activityHistory"}}  and data={"previousRequestToken": null}
22 Oct 00:55:28 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Response: {"customerHistoryRecords":[],"encodedRequestToken":null,"noDataFoundWithinTimeLimit":false,"lastRecordTimestamp":null,"voiceProfileAssociatedWithPerson":false}
22 Oct 00:55:28 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity data []
22 Oct 00:55:28 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity for device G2A1B505216600EE not found
22 Oct 00:55:28 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No activities from stored 1 entries found in queue (2)
22 Oct 00:55:28 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Reset expected activities
22 Oct 00:56:01 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Send Ping
22 Oct 00:56:18 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Command PUSH_EQUALIZER_STATE_CHANGE: {
    "dopplerId": {
        "deviceSerialNumber": "G2A1B505216600EE",
        "deviceType": "A3RMGO6LYLH7YN"
    },
    "bass": 0,
    "midrange": 0,
    "treble": 0,
    "destinationUserId": "A1UZ93DGNU3F5L"
}
22 Oct 00:56:18 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Simulate activity for G2A1B505216600EE with destinationUserId A1UZ93DGNU3F5L ... fetch in 3s
22 Oct 00:56:18 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Command PUSH_VOLUME_CHANGE: {
    "dopplerId": {
        "deviceSerialNumber": "G2A1B505216600EE",
        "deviceType": "A3RMGO6LYLH7YN"
    },
    "volumeSetting": 30,
    "isMuted": false,
    "destinationUserId": "A1UZ93DGNU3F5L"
}
22 Oct 00:56:22 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Get pushed activities ... 1 entries in queue (already running: false)
22 Oct 00:56:22 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No authentication check needed (time elapsed 537434)
22 Oct 00:56:22 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Sending Request with {"host":"www.amazon.ca","path":"/alexa-privacy/apd/rvh/customer-history-records-v2?startTime=1729583718036&endTime=1729670182037","method":"POST","timeout":10000,"headers":{"Accept-Language":"en-CA","anti-csrftoken-a2z":"hKxUAfaPOvv5r6Q9BZlKEZTGCY5jxdPC1gd05Iq3ilXtAAAAAGcXVOMAAAAB","referer":"https://www.amazon.ca/alexa-privacy/apd/activity?disableGlobalNav=true&ref=activityHistory"}}  and data={"previousRequestToken": null}
22 Oct 00:56:22 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Response: {"customerHistoryRecords":[],"encodedRequestToken":null,"noDataFoundWithinTimeLimit":false,"lastRecordTimestamp":null,"voiceProfileAssociatedWithPerson":false}
22 Oct 00:56:22 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity data []
22 Oct 00:56:22 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity for device G2A1B505216600EE not found
22 Oct 00:56:22 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No activities from stored 1 entries found in queue (0)
22 Oct 00:56:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Get pushed activities ... 1 entries in queue (already running: false)
22 Oct 00:56:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No authentication check needed (time elapsed 541627)
22 Oct 00:56:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Sending Request with {"host":"www.amazon.ca","path":"/alexa-privacy/apd/rvh/customer-history-records-v2?startTime=1729583718036&endTime=1729670186230","method":"POST","timeout":10000,"headers":{"Accept-Language":"en-CA","anti-csrftoken-a2z":"hKxUAfaPOvv5r6Q9BZlKEZTGCY5jxdPC1gd05Iq3ilXtAAAAAGcXVOMAAAAB","referer":"https://www.amazon.ca/alexa-privacy/apd/activity?disableGlobalNav=true&ref=activityHistory"}}  and data={"previousRequestToken": null}
22 Oct 00:56:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Response: {"customerHistoryRecords":[],"encodedRequestToken":null,"noDataFoundWithinTimeLimit":false,"lastRecordTimestamp":null,"voiceProfileAssociatedWithPerson":false}
22 Oct 00:56:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity data []
22 Oct 00:56:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity for device G2A1B505216600EE not found
22 Oct 00:56:26 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No activities from stored 1 entries found in queue (1)
22 Oct 00:56:30 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Get pushed activities ... 1 entries in queue (already running: false)
22 Oct 00:56:30 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No authentication check needed (time elapsed 545804)
22 Oct 00:56:30 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Sending Request with {"host":"www.amazon.ca","path":"/alexa-privacy/apd/rvh/customer-history-records-v2?startTime=1729583718036&endTime=1729670190407","method":"POST","timeout":10000,"headers":{"Accept-Language":"en-CA","anti-csrftoken-a2z":"hKxUAfaPOvv5r6Q9BZlKEZTGCY5jxdPC1gd05Iq3ilXtAAAAAGcXVOMAAAAB","referer":"https://www.amazon.ca/alexa-privacy/apd/activity?disableGlobalNav=true&ref=activityHistory"}}  and data={"previousRequestToken": null}
22 Oct 00:56:30 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Response: {"customerHistoryRecords":[],"encodedRequestToken":null,"noDataFoundWithinTimeLimit":false,"lastRecordTimestamp":null,"voiceProfileAssociatedWithPerson":false}
22 Oct 00:56:30 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity data []
22 Oct 00:56:30 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Activity for device G2A1B505216600EE not found
22 Oct 00:56:30 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: No activities from stored 1 entries found in queue (2)
22 Oct 00:56:30 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Reset expected activities
danielbrunt57 commented 1 month ago

@bbindreiter So, my problem persists whenever I deploy any change I make or when I restart flows. It seems that the existing HTTP2Push connection is not terminated/re-used when the nodes are restarted via these means in NR. To fix the issue I have to restart the NR add-on. Am I doing something wrong or is this a bug that can be fixed?

23 Oct 22:22:22 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Close: undefined: undefined
23 Oct 22:22:22 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Retry Connection in 10s
23 Oct 22:22:32 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote: Update access token ...
23 Oct 22:22:32 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Use host bob-dispatch-prod-na.amazon.com
23 Oct 22:22:32 - [debug] [alexa-remote-account:14f19d12849e6414] Alexa-Remote HTTP2-PUSH: Initialization completed
danielbrunt57 commented 1 week ago

When deploying any change I make or when I restart flows, the original http2 connection is severed and therefore the code sees it has stopped but proceeds to restart it when it should not as NR will initialize and start a new one resulting in there being two on the go. The first continually closes & is restarted. Eventually the code gives up on it and leaves it closed but that takes hours I think. Somewhere the code should issue a call to the close function in alexa-remote2 before initializing a new connection as was pointed out to me by Apollon77 but I don't know where to insert it into the library.

See https://github.com/Apollon77/alexa-remote/issues/213