tsightler / ring-mqtt

Ring devices to MQTT Bridge
MIT License
600 stars 106 forks source link

Stopped working after adding new Eufy Cams with go2rtc. Will not stream. #770

Closed bkr1969 closed 10 months ago

bkr1969 commented 10 months ago

Describe the Bug

My Generic camera no longer streams

Steps to Reproduce

Clicking on still image gives error

Expected Behavior

Worked fine until adding new cameras with go2rtc

Log Output

2024-01-01T18:07:46.535Z ring-rtsp [Front Door] Sending command to activate live stream ON-DEMAND
2024-01-01T18:07:46.540Z ring-mqtt [Front Door] Received set live stream state ON-DEMAND rtsp://127.0.0.1:8554/11d2064c5518be0ea3feefc2c996f5ff
2024-01-01T18:07:46.540Z ring-mqtt [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/stream/state ON
2024-01-01T18:07:46.540Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/stream/attributes {"status":"activating"}
2024-01-01T18:07:46.540Z ring-mqtt [Front Door] Acquiring a live stream WebRTC signaling session ticket
2024-01-01T18:07:46.665Z ring-rtsp [Front Door] State indicates live stream is activating
2024-01-01T18:07:46.995Z ring-mqtt [Front Door] Live stream WebRTC signaling session ticket acquired, starting live stream worker
2024-01-01T18:07:46.996Z ring-wrtc [Front Door] Live stream WebRTC worker received start command
2024-01-01T18:07:47.009Z ring-wrtc [Front Door] Live stream transcoding process is starting
2024-01-01T18:07:47.254Z ring-wrtc [Front Door] Websocket signaling for WebRTC session connected successfully
2024-01-01T18:07:47.712Z ring-wrtc [Front Door] Live stream transcoding process has started
2024-01-01T18:07:48.718Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/stream/attributes {"status":"active"}
2024-01-01T18:07:48.719Z ring-wrtc [Front Door] Live stream WebRTC session is connected
2024-01-01T18:07:48.915Z ring-rtsp [Front Door] State indicates live stream is active
2024-01-01T18:07:50.212Z ring-rtsp [go2rtc] DBG [exec] run launch=3.697521534s
2024-01-01T18:07:50.213Z ring-rtsp [go2rtc] DBG [streams] start producer url=exec:/app/ring-mqtt/scripts/start-stream.sh e04f43a47a81 live ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81 {output}
2024-01-01T18:07:50.451Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:46804: i/o timeout"
2024-01-01T18:07:52.468Z ring-rtsp [go2rtc] DBG [rtsp] handle=read tcp 172.30.33.2:8554->172.30.32.1:46820: read: connection reset by peer
2024-01-01T18:07:52.468Z ring-rtsp [go2rtc] DBG [streams] stop producer url=exec:/app/ring-mqtt/scripts/start-stream.sh e04f43a47a81 live ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81 {output}
2024-01-01T18:07:52.469Z ring-rtsp [go2rtc] DBG [rtsp] disconnect stream=e04f43a47a81_live
2024-01-01T18:07:52.523Z ring-wrtc [Front Door] Live stream WebRTC session has disconnected
2024-01-01T18:07:52.523Z ring-mqtt [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/stream/state OFF
2024-01-01T18:07:52.524Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/stream/attributes {"status":"inactive"}
2024-01-01T18:07:52.647Z ring-rtsp [Front Door] State indicates live stream has gone inactive
2024-01-01T18:07:57.457Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:32838: i/o timeout"
2024-01-01T18:08:03.564Z ring-mqtt [Front Door] Requesting an updated interval snapshot
2024-01-01T18:08:04.143Z ring-mqtt [Front Door] Successfully retrieved updated interval snapshot
2024-01-01T18:08:04.143Z ring-mqtt [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/image <binary_image_data>
2024-01-01T18:08:04.143Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/attributes {"timestamp":1704132484,"type":"interval"}
2024-01-01T18:08:04.461Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:33714: i/o timeout"
2024-01-01T18:08:11.465Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:33722: i/o timeout"
2024-01-01T18:08:15.810Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:51534: i/o timeout"
2024-01-01T18:08:22.815Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:41516: i/o timeout"
2024-01-01T18:08:25.472Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:41520: i/o timeout"
2024-01-01T18:08:29.818Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:41526: i/o timeout"
2024-01-01T18:08:32.477Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:52556: i/o timeout"
2024-01-01T18:08:33.564Z ring-mqtt [Front Door] Requesting an updated interval snapshot
2024-01-01T18:08:33.941Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/info/state {"stream_Source":"rtsp://bkr1969:Ringcam@fab786b8-ring-mqtt:8554/e04f43a47a81_live","still_Image_URL":"https://homeassistant:8123{{ states.camera.front_door_snapshot.attributes.entity_picture }}","firmwareStatus":"Up to Date","lastUpdate":"2024-01-01T18:08:18Z","wirelessNetwork":"Eeronet","wirelessSignal":-50}
2024-01-01T18:08:33.942Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/wireless/attributes {"wirelessNetwork":"Eeronet","wirelessSignal":-50}
2024-01-01T18:08:34.020Z ring-mqtt [Front Door] Successfully retrieved updated interval snapshot
2024-01-01T18:08:34.021Z ring-mqtt [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/image <binary_image_data>
2024-01-01T18:08:34.022Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/attributes {"timestamp":1704132514,"type":"interval"}
2024-01-01T18:08:36.823Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:52558: i/o timeout"
2024-01-01T18:08:39.481Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:52564: i/o timeout"
2024-01-01T18:08:43.828Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:52670: i/o timeout"
2024-01-01T18:08:46.485Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:52686: i/o timeout"
2024-01-01T18:08:50.832Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:52688: i/o timeout"
2024-01-01T18:08:53.489Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:45008: i/o timeout"
2024-01-01T18:08:57.836Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:45012: i/o timeout"
2024-01-01T18:09:00.492Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:45022: i/o timeout"
2024-01-01T18:09:03.568Z ring-mqtt [Front Door] Requesting an updated interval snapshot
2024-01-01T18:09:04.334Z ring-mqtt [Front Door] Successfully retrieved updated interval snapshot
2024-01-01T18:09:04.335Z ring-mqtt [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/image <binary_image_data>
2024-01-01T18:09:04.336Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/attributes {"timestamp":1704132544,"type":"interval"}
2024-01-01T18:09:04.841Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:49496: i/o timeout"
2024-01-01T18:09:07.497Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:49506: i/o timeout"
2024-01-01T18:09:11.847Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:49512: i/o timeout"
2024-01-01T18:09:14.500Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:60506: i/o timeout"
2024-01-01T18:09:18.852Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:60508: i/o timeout"
2024-01-01T18:09:21.505Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:60510: i/o timeout"
2024-01-01T18:09:28.509Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:34614: i/o timeout"
2024-01-01T18:09:33.574Z ring-mqtt [Front Door] Requesting an updated interval snapshot
2024-01-01T18:09:34.144Z ring-mqtt [Front Door] Successfully retrieved updated interval snapshot
2024-01-01T18:09:34.144Z ring-mqtt [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/image <binary_image_data>
2024-01-01T18:09:34.144Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/attributes {"timestamp":1704132574,"type":"interval"}
2024-01-01T18:09:35.513Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:57570: i/o timeout"
2024-01-01T18:09:42.518Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:45468: i/o timeout"
2024-01-01T18:09:46.866Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:45480: i/o timeout"
2024-01-01T18:09:49.522Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:45488: i/o timeout"
2024-01-01T18:09:53.870Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:41244: i/o timeout"
2024-01-01T18:09:56.527Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:41260: i/o timeout"
2024-01-01T18:10:00.874Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:41262: i/o timeout"
2024-01-01T18:10:03.530Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:54782: i/o timeout"
2024-01-01T18:10:03.574Z ring-mqtt [Front Door] Requesting an updated interval snapshot
2024-01-01T18:10:04.127Z ring-mqtt [Front Door] Successfully retrieved updated interval snapshot
2024-01-01T18:10:04.127Z ring-mqtt [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/image <binary_image_data>
2024-01-01T18:10:04.127Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/attributes {"timestamp":1704132604,"type":"interval"}
2024-01-01T18:10:14.882Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:56194: i/o timeout"
2024-01-01T18:10:24.542Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:40432: i/o timeout"
2024-01-01T18:10:28.891Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:40434: i/o timeout"
2024-01-01T18:10:31.546Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:40436: i/o timeout"
2024-01-01T18:10:33.577Z ring-mqtt [Front Door] Requesting an updated interval snapshot
2024-01-01T18:10:34.022Z ring-mqtt [Front Door] Successfully retrieved updated interval snapshot
2024-01-01T18:10:34.023Z ring-mqtt [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/image <binary_image_data>
2024-01-01T18:10:34.024Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/attributes {"timestamp":1704132634,"type":"interval"}
2024-01-01T18:10:35.894Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:37148: i/o timeout"
2024-01-01T18:10:38.550Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:37158: i/o timeout"
2024-01-01T18:10:42.898Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:46946: i/o timeout"
2024-01-01T18:10:45.553Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:46958: i/o timeout"
2024-01-01T18:10:49.903Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:46974: i/o timeout"
2024-01-01T18:11:03.578Z ring-mqtt [Front Door] Requesting an updated interval snapshot
2024-01-01T18:11:03.912Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:37350: i/o timeout"
2024-01-01T18:11:04.235Z ring-mqtt [Front Door] Successfully retrieved updated interval snapshot
2024-01-01T18:11:04.235Z ring-mqtt [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/image <binary_image_data>
2024-01-01T18:11:04.236Z ring-attr [Front Door] ring/2148f1ae-7761-49f2-44eb-f1afb06c1b58/camera/e04f43a47a81/snapshot/attributes {"timestamp":1704132664,"type":"interval"}
2024-01-01T18:11:06.563Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:37356: i/o timeout"
2024-01-01T18:11:10.916Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:37366: i/o timeout"
2024-01-01T18:11:13.567Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:60702: i/o timeout"
2024-01-01T18:11:17.922Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:60708: i/o timeout"
2024-01-01T18:11:20.570Z ring-rtsp [go2rtc] WRN github.com/AlexxIT/go2rtc/internal/rtsp/rtsp.go:225 > error="read tcp 172.30.33.2:8554->172.30.32.1:60712: i/o timeout"

Screenshots

Not a screen shot, but here is the specific error:

Failed to start WebRTC stream: RTSPtoWeb server failure: stream channel codec not ready, possible stream offline: Internal Server Error

I can stream directly with go2rtc, but the generic camera entity gives the above error.

Config File

Config is exactly per documentation and was working last week.

Install Type

Add-on

Version

v5.6.3

Operating System

Home Assistant OS

Architecture

aarch64

Machine Details

HA Blue

tsightler commented 10 months ago

I have no visibility into what changes you made to go2rtc, but since it was working before that point, it seems clear that those changes are the most likely suspect. I would suggest backing out those changes and seeing if it works. The logs show errors with the stream getting from ring-mqtt to the host vs any issues in ring-mqtt itself, thus that is the best place to look. Unfortunately, I can't help you with that. Good luck!

bkr1969 commented 10 months ago

I guess my wondering is why I can stream the address in go2rtc, but not as a generic camera not via VLC. This may be more of an issue with the generic camera because my snapshots are updating and working, just no stream. Please let me know if you happen to have any thoughts. Thanks.