[Support]: Recording video stutters and it's not aligned to audio #11159

ferrarimarco · 2024-04-29T16:44:17Z

ferrarimarco
Apr 29, 2024

Describe the problem you are having

Hi! Thanks for working on Frigate :)

I'm having an issue with a Reolink E1 zoom camera: the video it records through Frigate visibly stutters when the event is in progress. Pre and post recordings are fine. Also, if I enable audio recording using the preset-record-generic-audio-copy preset, I noticed that the audio is out of sync (about 5-8 seconds).

There are no visible clues in the output logs about errors or warnings, even after enabling debug logs for the default logger, besides that sendFile alert.

Version

0.13.2-6476F8A

Frigate config file

---
mqtt:
  host: "mqtt-host"
  port: 1883

detectors:
  coral:
    type: edgetpu
    device: pci

ffmpeg:
  # Enable acceleration
  hwaccel_args: preset-vaapi
  output_args:
    record: preset-record-generic-audio-copy

# Configuration for recordings
record:
  enabled: true
  events:
    # Number of seconds after the event to include.
    # Doesn't have effect if record.events.retain.mode is not set to "all"
    post_capture: 30
    # Number of seconds before the event to include.
    # Doesn't have effect if record.events.retain.mode is not set to "all"
    pre_capture: 30
    retain:
      # Retention days
      default: 10
      # Recording retention mode for events.
      # all - save all recording segments for events regardless of activity
      # motion - save all recordings segments for events with any detected motion
      # active_objects - save all recording segments for event with active/moving objects
      # Default is "motion" (Frigate 0.12.0)
      mode: all

# Disable RTMP re-streaming to spare resources
rtmp:
  enabled: false

# Configuration for the snapshots written to the clips directory for each event
snapshots:
  bounding_box: true
  enabled: true
  retain:
    # Retention days
    default: 10

timestamp_style:
  format: "%Y-%m-%dT%H:%M:%S"
  # Position of the timestamp. "tl" (top left), "tr" (top right), "bl" (bottom left), "br" (bottom right)
  position: "tl"

cameras:
  cam-3:
    ffmpeg:
      inputs:
        - path: "rtsp://USER:PASS@cam-ip:554/h264Preview_01_sub"
          roles:
            - detect
        - path: "rtsp://USER:PASS@cam-ip:554/h264Preview_01_main"
          roles:
            - record
    detect:
      height: 480
      width: 640
...

Relevant log output

frigate  | 2024-04-29 15:31:06.858489322  [INFO] Starting go2rtc...
frigate  | 2024-04-29 15:31:06.975428371  15:31:06.975 INF go2rtc version 1.8.4 linux/amd64
frigate  | 2024-04-29 15:31:06.975895394  15:31:06.975 INF [api] listen addr=:1984
frigate  | 2024-04-29 15:31:06.975976618  15:31:06.975 INF [rtsp] listen addr=:8554
frigate  | 2024-04-29 15:31:06.976128712  15:31:06.976 INF [webrtc] listen addr=:8555
frigate  | 2024-04-29 15:31:07.625685834  [2024-04-29 15:31:07] frigate.app                    INFO    : Starting Frigate (0.13.2-6476f8a)
frigate  | 2024-04-29 15:31:07.647020164  [2024-04-29 15:31:07] peewee_migrate.logs            INFO    : Starting migrations
frigate  | 2024-04-29 15:31:07.650609530  [2024-04-29 15:31:07] peewee_migrate.logs            INFO    : There is nothing to migrate
frigate  | 2024-04-29 15:31:07.654278543  [2024-04-29 15:31:07] frigate.app                    INFO    : Recording process started: 225
frigate  | 2024-04-29 15:31:07.656216454  [2024-04-29 15:31:07] frigate.app                    INFO    : go2rtc process pid: 91
frigate  | 2024-04-29 15:31:07.676916642  [2024-04-29 15:31:07] frigate.app                    INFO    : Output process started: 236
frigate  | 2024-04-29 15:31:07.720400801  [2024-04-29 15:31:07] frigate.app                    INFO    : Camera processor started for cam-3: 243
frigate  | 2024-04-29 15:31:07.720403761  [2024-04-29 15:31:07] frigate.app                    INFO    : Capture process started for cam-3: 244
frigate  | 2024-04-29 15:31:07.768654635  [2024-04-29 15:31:07] detector.coral                 INFO    : Starting detection process: 235
frigate  | 2024-04-29 15:31:07.768657971  [2024-04-29 15:31:07] frigate.detectors.plugins.edgetpu_tfl INFO    : Attempting to load TPU as pci
frigate  | 2024-04-29 15:31:07.772187582  [2024-04-29 15:31:07] frigate.detectors.plugins.edgetpu_tfl INFO    : TPU found
frigate  | 2024-04-29 15:31:16.559650966  [INFO] Starting go2rtc healthcheck service...
frigate  | 2024-04-29 15:34:55.080929383  10.0.0.2 - - [29/Apr/2024:15:34:55 +0000] "GET /api/events/1714404892.930489-j7qhsg/snapshot.jpg HTTP/1.1" 200 28661 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:35:06.257486856  10.0.0.2 - - [29/Apr/2024:15:35:06 +0000] "GET /api/events/1714404892.930489-j7qhsg/clip.mp4 HTTP/1.1" 200 33577650 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:35:09.736104470  10.0.0.2 - - [29/Apr/2024:15:35:09 +0000] "GET /api/events/1714404892.930489-j7qhsg/snapshot.jpg HTTP/1.1" 200 30796 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:35:20.268120714  10.0.0.2 - - [29/Apr/2024:15:35:20 +0000] "GET /api/events/1714404892.930489-j7qhsg/clip.mp4 HTTP/1.1" 200 33577650 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:44:16.677048690  10.0.0.2 - - [29/Apr/2024:15:44:16 +0000] "GET /api/events/1714405456.234159-yis2e4/snapshot.jpg HTTP/1.1" 200 27133 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:44:27.843813248  10.0.0.2 - - [29/Apr/2024:15:44:27 +0000] "GET /api/events/1714405456.234159-yis2e4/clip.mp4 HTTP/1.1" 200 31233248 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:44:31.023355351  10.0.0.2 - - [29/Apr/2024:15:44:31 +0000] "GET /api/events/1714405456.234159-yis2e4/snapshot.jpg HTTP/1.1" 200 28006 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:44:42.365188933  10.0.0.2 - - [29/Apr/2024:15:44:42 +0000] "GET /api/events/1714405456.234159-yis2e4/clip.mp4 HTTP/1.1" 200 39618405 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:44:45.231491533  10.0.0.2 - - [29/Apr/2024:15:44:45 +0000] "GET /api/events/1714405459.641865-oc3y6j/snapshot.jpg HTTP/1.1" 200 31059 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:44:56.767178309  10.0.0.2 - - [29/Apr/2024:15:44:56 +0000] "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1" 200 50083651 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:45:00.866415770  10.0.0.2 - - [29/Apr/2024:15:45:00 +0000] "GET /api/events/1714405459.641865-oc3y6j/snapshot.jpg HTTP/1.1" 200 31059 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:45:11.543541468  10.0.0.2 - - [29/Apr/2024:15:45:11 +0000] "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1" 200 50083651 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:45:15.467789931  10.0.0.2 - - [29/Apr/2024:15:45:15 +0000] "GET /api/events/1714405467.332929-t2h54u/snapshot.jpg HTTP/1.1" 200 29155 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:45:27.588296514  10.0.0.2 - - [29/Apr/2024:15:45:27 +0000] "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1" 200 62409796 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:45:29.554687857  10.0.0.2 - - [29/Apr/2024:15:45:29 +0000] "GET /api/events/1714405456.234159-yis2e4/snapshot.jpg HTTP/1.1" 200 29956 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:45:32.255130897  10.204.171.226 - - [29/Apr/2024:15:45:32 +0000] "GET /api/events?cameras=all&labels=all&zones=all&sub_labels=all&time_range=00:00,24:00&timezone=Europe%2FRome&favorites=0&is_submitted=-1&in_progress=0&include_thumbnails=0&limit=25 HTTP/1.1" 200 11993 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:32.265426047  10.204.171.226 - - [29/Apr/2024:15:45:32 +0000] "GET /api/config HTTP/1.1" 200 8484 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:32.266313900  10.204.171.226 - - [29/Apr/2024:15:45:32 +0000] "GET /api/labels HTTP/1.1" 200 11 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:32.266318024  10.204.171.226 - - [29/Apr/2024:15:45:32 +0000] "GET /api/events?in_progress=1&include_thumbnails=0 HTTP/1.1" 200 3 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:32.267898120  10.204.171.226 - - [29/Apr/2024:15:45:32 +0000] "GET /api/sub_labels?split_joined=1 HTTP/1.1" 200 3 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:32.284644518  10.204.171.226 - - [29/Apr/2024:15:45:32 +0000] "GET /api/events/1714405467.332929-t2h54u/thumbnail.jpg HTTP/1.1" 200 4240 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:32.286671001  10.204.171.226 - - [29/Apr/2024:15:45:32 +0000] "GET /api/events/1714405459.641865-oc3y6j/thumbnail.jpg HTTP/1.1" 200 5006 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:32.289359738  10.204.171.226 - - [29/Apr/2024:15:45:32 +0000] "GET /api/events/1714405456.234159-yis2e4/thumbnail.jpg HTTP/1.1" 200 4394 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:40.144773921  10.0.0.2 - - [29/Apr/2024:15:45:40 +0000] "GET /api/events/1714405456.234159-yis2e4/clip.mp4 HTTP/1.1" 200 39618405 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:45:41.075749052  10.204.171.226 - - [29/Apr/2024:15:45:41 +0000] "GET /api/timeline?source_id=1714405456.234159-yis2e4 HTTP/1.1" 200 553 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:41.078169280  10.204.171.226 - - [29/Apr/2024:15:45:41 +0000] "GET /api/config HTTP/1.1" 200 8484 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:41.078377344  10.204.171.226 - - [29/Apr/2024:15:45:41 +0000] "GET /api/cam-3/recordings?before=1714405501.045582&after=1714405426.234159 HTTP/1.1" 200 1035 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:41.111996917  10.204.171.226 - - [29/Apr/2024:15:45:41 +0000] "GET /vod/event/1714405456.234159-yis2e4/master.m3u8 HTTP/1.1" 200 155 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:41.132595947  10.204.171.226 - - [29/Apr/2024:15:45:41 +0000] "GET /vod/event/1714405456.234159-yis2e4/index-v1.m3u8 HTTP/1.1" 200 199 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:41.276353540  10.204.171.226 - - [29/Apr/2024:15:45:41 +0000] "GET /vod/event/1714405456.234159-yis2e4/seg-1-v1.ts HTTP/1.1" 200 10663736 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:41.494723876  10.204.171.226 - - [29/Apr/2024:15:45:41 +0000] "GET /vod/event/1714405456.234159-yis2e4/seg-2-v1.ts HTTP/1.1" 200 8564152 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:41.693567441  10.204.171.226 - - [29/Apr/2024:15:45:41 +0000] "GET /vod/event/1714405456.234159-yis2e4/seg-3-v1.ts HTTP/1.1" 200 10687800 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:42.367365959  10.204.171.226 - - [29/Apr/2024:15:45:42 +0000] "GET /vod/event/1714405456.234159-yis2e4/seg-4-v1.ts HTTP/1.1" 200 6109624 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:43.584368927  10.0.0.2 - - [29/Apr/2024:15:45:43 +0000] "GET /api/events/1714405459.641865-oc3y6j/snapshot.jpg HTTP/1.1" 200 31059 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:45:47.118758069  10.204.171.226 - - [29/Apr/2024:15:45:47 +0000] "GET /api/sub_labels?split_joined=1 HTTP/1.1" 200 3 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:47.119598596  10.204.171.226 - - [29/Apr/2024:15:45:47 +0000] "GET /api/labels HTTP/1.1" 200 11 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:47.119603052  10.204.171.226 - - [29/Apr/2024:15:45:47 +0000] "GET /api/events?in_progress=1&include_thumbnails=0 HTTP/1.1" 200 3 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:47.121848761  10.204.171.226 - - [29/Apr/2024:15:45:47 +0000] "GET /api/events?cameras=all&labels=all&zones=all&sub_labels=all&time_range=00:00,24:00&timezone=Europe%2FRome&favorites=0&is_submitted=-1&in_progress=0&include_thumbnails=0&limit=25 HTTP/1.1" 200 11993 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:47.132603541  10.204.171.226 - - [29/Apr/2024:15:45:47 +0000] "GET /api/timeline?source_id=1714405456.234159-yis2e4 HTTP/1.1" 200 553 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:47.169708761  10.204.171.226 - - [29/Apr/2024:15:45:47 +0000] "GET /vod/event/1714405456.234159-yis2e4/seg-5-v1.ts HTTP/1.1" 200 8546104 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:52.439241899  10.204.171.226 - - [29/Apr/2024:15:45:52 +0000] "GET /vod/event/1714405456.234159-yis2e4/seg-6-v1.ts HTTP/1.1" 200 14962168 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:45:54.122703954  10.0.0.2 - - [29/Apr/2024:15:45:54 +0000] "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1" 200 50083651 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:45:57.698687635  10.0.0.2 - - [29/Apr/2024:15:45:57 +0000] "GET /api/events/1714405467.332929-t2h54u/snapshot.jpg HTTP/1.1" 200 29155 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:02.232157451  10.204.171.226 - - [29/Apr/2024:15:46:02 +0000] "GET /vod/event/1714405456.234159-yis2e4/seg-8-v1.ts HTTP/1.1" 200 8296440 "http://frigate-host:5000/events" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:46:08.505360921  10.0.0.2 - - [29/Apr/2024:15:46:08 +0000] "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1" 200 62409796 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:10.591587867  10.0.0.2 - - [29/Apr/2024:15:46:10 +0000] "GET /api/events/1714405459.641865-oc3y6j/snapshot.jpg HTTP/1.1" 200 31059 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:21.949795414  2024/04/29 15:46:21 [alert] 134#134: *322 sendfile() reported that "/tmp/cache/clip_cam-3_1714405429.641865-1714405505.030375.mp4" was truncated at 0 while sending response to client, client: 10.0.0.2, server: , request: "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1", upstream: "http://127.0.0.1:5001/events/1714405459.641865-oc3y6j/clip.mp4", host: "frigate-host:5000"
frigate  | 2024-04-29 15:46:21.949798981  10.0.0.2 - - [29/Apr/2024:15:46:21 +0000] "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1" 200 0 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:21.959993419  2024/04/29 15:46:21 [alert] 134#134: *324 sendfile() reported that "/tmp/cache/clip_cam-3_1714405429.641865-1714405505.030375.mp4" was truncated at 0 while sending response to client, client: 10.0.0.2, server: , request: "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1", upstream: "http://127.0.0.1:5001/events/1714405459.641865-oc3y6j/clip.mp4", host: "frigate-host:5000"
frigate  | 2024-04-29 15:46:21.959997140  10.0.0.2 - - [29/Apr/2024:15:46:21 +0000] "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1" 200 0 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:21.969315519  2024/04/29 15:46:21 [alert] 134#134: *326 sendfile() reported that "/tmp/cache/clip_cam-3_1714405429.641865-1714405505.030375.mp4" was truncated at 0 while sending response to client, client: 10.0.0.2, server: , request: "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1", upstream: "http://127.0.0.1:5001/events/1714405459.641865-oc3y6j/clip.mp4", host: "frigate-host:5000"
frigate  | 2024-04-29 15:46:21.969322408  10.0.0.2 - - [29/Apr/2024:15:46:21 +0000] "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1" 200 0 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:21.979220386  2024/04/29 15:46:21 [alert] 134#134: *328 sendfile() reported that "/tmp/cache/clip_cam-3_1714405429.641865-1714405505.030375.mp4" was truncated at 0 while sending response to client, client: 10.0.0.2, server: , request: "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1", upstream: "http://127.0.0.1:5001/events/1714405459.641865-oc3y6j/clip.mp4", host: "frigate-host:5000"
frigate  | 2024-04-29 15:46:21.979223620  10.0.0.2 - - [29/Apr/2024:15:46:21 +0000] "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1" 200 0 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:21.989078098  2024/04/29 15:46:21 [alert] 134#134: *330 sendfile() reported that "/tmp/cache/clip_cam-3_1714405429.641865-1714405505.030375.mp4" was truncated at 0 while sending response to client, client: 10.0.0.2, server: , request: "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1", upstream: "http://127.0.0.1:5001/events/1714405459.641865-oc3y6j/clip.mp4", host: "frigate-host:5000"
frigate  | 2024-04-29 15:46:21.989081889  10.0.0.2 - - [29/Apr/2024:15:46:21 +0000] "GET /api/events/1714405459.641865-oc3y6j/clip.mp4 HTTP/1.1" 200 0 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:22.097172911  10.0.0.2 - - [29/Apr/2024:15:46:22 +0000] "GET /api/events/1714405467.332929-t2h54u/snapshot.jpg HTTP/1.1" 200 29155 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:25.516225510  10.204.171.226 - - [29/Apr/2024:15:46:25 +0000] "GET /ws HTTP/1.1" 101 43597 "-" "Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/125.0.0.0 Safari/537.36" "-"
frigate  | 2024-04-29 15:46:32.849613148  10.0.0.2 - - [29/Apr/2024:15:46:32 +0000] "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1" 200 62409796 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:34.817556822  10.0.0.2 - - [29/Apr/2024:15:46:34 +0000] "GET /api/events/1714405467.332929-t2h54u/snapshot.jpg HTTP/1.1" 200 29155 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:45.688430693  10.0.0.2 - - [29/Apr/2024:15:46:45 +0000] "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1" 200 62409796 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:47.689780955  10.0.0.2 - - [29/Apr/2024:15:46:47 +0000] "GET /api/events/1714405467.332929-t2h54u/snapshot.jpg HTTP/1.1" 200 29155 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:46:58.508981061  10.0.0.2 - - [29/Apr/2024:15:46:58 +0000] "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1" 200 62409796 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:47:00.538277990  10.0.0.2 - - [29/Apr/2024:15:47:00 +0000] "GET /api/events/1714405467.332929-t2h54u/snapshot.jpg HTTP/1.1" 200 29155 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:47:12.192848311  2024/04/29 15:47:12 [alert] 133#133: *354 sendfile() reported that "/tmp/cache/clip_cam-3_1714405437.332929-1714405540.025639.mp4" was truncated at 0 while sending response to client, client: 10.0.0.2, server: , request: "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1", upstream: "http://127.0.0.1:5001/events/1714405467.332929-t2h54u/clip.mp4", host: "frigate-host:5000"
frigate  | 2024-04-29 15:47:12.192851902  10.0.0.2 - - [29/Apr/2024:15:47:12 +0000] "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1" 200 0 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:47:12.202592078  2024/04/29 15:47:12 [alert] 133#133: *356 sendfile() reported that "/tmp/cache/clip_cam-3_1714405437.332929-1714405540.025639.mp4" was truncated at 0 while sending response to client, client: 10.0.0.2, server: , request: "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1", upstream: "http://127.0.0.1:5001/events/1714405467.332929-t2h54u/clip.mp4", host: "frigate-host:5000"
frigate  | 2024-04-29 15:47:12.202595589  10.0.0.2 - - [29/Apr/2024:15:47:12 +0000] "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1" 200 0 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:47:12.211845565  2024/04/29 15:47:12 [alert] 133#133: *358 sendfile() reported that "/tmp/cache/clip_cam-3_1714405437.332929-1714405540.025639.mp4" was truncated at 0 while sending response to client, client: 10.0.0.2, server: , request: "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1", upstream: "http://127.0.0.1:5001/events/1714405467.332929-t2h54u/clip.mp4", host: "frigate-host:5000"
frigate  | 2024-04-29 15:47:12.211849319  10.0.0.2 - - [29/Apr/2024:15:47:12 +0000] "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1" 200 0 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:47:12.222138767  2024/04/29 15:47:12 [alert] 133#133: *360 sendfile() reported that "/tmp/cache/clip_cam-3_1714405437.332929-1714405540.025639.mp4" was truncated at 0 while sending response to client, client: 10.0.0.2, server: , request: "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1", upstream: "http://127.0.0.1:5001/events/1714405467.332929-t2h54u/clip.mp4", host: "frigate-host:5000"
frigate  | 2024-04-29 15:47:12.222147330  10.0.0.2 - - [29/Apr/2024:15:47:12 +0000] "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1" 200 0 "-" "python-requests/2.31.0" "-"
frigate  | 2024-04-29 15:47:12.231920954  2024/04/29 15:47:12 [alert] 133#133: *362 sendfile() reported that "/tmp/cache/clip_cam-3_1714405437.332929-1714405540.025639.mp4" was truncated at 0 while sending response to client, client: 10.0.0.2, server: , request: "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1", upstream: "http://127.0.0.1:5001/events/1714405467.332929-t2h54u/clip.mp4", host: "frigate-host:5000"
frigate  | 2024-04-29 15:47:12.231924887  10.0.0.2 - - [29/Apr/2024:15:47:12 +0000] "GET /api/events/1714405467.332929-t2h54u/clip.mp4 HTTP/1.1" 200 0 "-" "python-requests/2.31.0" "-"

FFprobe output from your camera

[{"return_code":0,"stderr":"","stdout":{"programs":[],"streams":[{"avg_frame_rate":"0/0","codec_long_name":"H.264/AVC/MPEG-4AVC/MPEG-4part10","height":480,"width":640},{"avg_frame_rate":"0/0","codec_long_name":"AAC(AdvancedAudioCoding)"}]}},{"return_code":0,"stderr":"","stdout":{"programs":[],"streams":[{"avg_frame_rate":"0/0","codec_long_name":"H.264/AVC/MPEG-4AVC/MPEG-4part10","height":1920,"width":2560},{"avg_frame_rate":"0/0","codec_long_name":"AAC(AdvancedAudioCoding)"}]}}]

Frigate stats

{"cameras":{"cam-3":{"audio_dBFS":0.0,"audio_rms":0.0,"camera_fps":5.0,"capture_pid":250,"detection_enabled":1,"detection_fps":1.1,"ffmpeg_pid":255,"pid":249,"process_fps":5.1,"skipped_fps":0.0}},"cpu_usages":{"1":{"cmdline":"/package/admin/s6/command/s6-svscan -d4 -- /run/service","cpu":"0.0","cpu_average":"0","mem":"0.0"},"15":{"cmdline":"s6-supervise s6-linux-init-shutdownd","cpu":"0.0","cpu_average":"0","mem":"0.0"},"16":{"cmdline":"/package/admin/s6-linux-init/command/s6-linux-init-shutdownd -c /run/s6/basedir -g 3000 -C -B","cpu":"0.0","cpu_average":"0","mem":"0.0"},"24":{"cmdline":"s6-supervise nginx","cpu":"0.0","cpu_average":"0","mem":"0.0"},"25":{"cmdline":"s6-supervise frigate-log","cpu":"0.0","cpu_average":"0","mem":"0.0"},"26":{"cmdline":"s6-supervise s6rc-oneshot-runner","cpu":"0.0","cpu_average":"0","mem":"0.0"},"27":{"cmdline":"s6-supervise frigate","cpu":"0.0","cpu_average":"0","mem":"0.0"},"28":{"cmdline":"s6-supervise go2rtc","cpu":"0.0","cpu_average":"0","mem":"0.0"},"29":{"cmdline":"s6-supervise go2rtc-healthcheck","cpu":"0.0","cpu_average":"0","mem":"0.0"},"30":{"cmdline":"s6-supervise go2rtc-log","cpu":"0.0","cpu_average":"0","mem":"0.0"},"31":{"cmdline":"s6-supervise s6rc-fdholder","cpu":"0.0","cpu_average":"0","mem":"0.0"},"32":{"cmdline":"s6-supervise nginx-log","cpu":"0.0","cpu_average":"0","mem":"0.0"},"40":{"cmdline":"/package/admin/s6-2.11.3.2/command/s6-fdholderd -1 -i data/rules","cpu":"0.0","cpu_average":"0","mem":"0.0"},"42":{"cmdline":"/package/admin/s6/command/s6-ipcserverd -1 -- /package/admin/s6/command/s6-ipcserver-access -v0 -E -l0 -i data/rules -- /package/admin/s6/command/s6-sudod -t 30000 -- /package/admin/s6-rc/command/s6-rc-oneshot-run -l ../.. --","cpu":"0.0","cpu_average":"0","mem":"0.0"},"79":{"cmdline":"s6-log -b -- T 1 n0 s10000000 T /dev/shm/logs/nginx","cpu":"0.0","cpu_average":"0","mem":"0.0"},"80":{"cmdline":"s6-log -b -- T 1 n0 s10000000 T /dev/shm/logs/go2rtc","cpu":"0.0","cpu_average":"0","mem":"0.0"},"83":{"cmdline":"s6-log -b -- T 1 n0 s10000000 T /dev/shm/logs/frigate","cpu":"0.0","cpu_average":"0","mem":"0.0"},"90":{"cmdline":"/usr/local/go2rtc/bin/go2rtc -config=/dev/shm/go2rtc.yaml","cpu":"0.0","cpu_average":"0","mem":"0.5"},"110":{"cmdline":"bash ./run.user go2rtc-healthcheck","cpu":"0.0","cpu_average":"0","mem":"0.1"},"114":{"cmdline":"python3 -u -m frigate","cpu":"0.7","cpu_average":"0","mem":"5.4"},"122":{"cmdline":"nginx: master process nginx","cpu":"0.0","cpu_average":"0","mem":"0.4"},"145":{"cmdline":"nginx: worker process","cpu":"0.0","cpu_average":"0","mem":"0.2"},"146":{"cmdline":"nginx: worker process","cpu":"0.1","cpu_average":"0","mem":"0.2"},"147":{"cmdline":"nginx: cache manager process","cpu":"0.0","cpu_average":"0","mem":"0.2"},"223":{"cmdline":"frigate.logger       ","cpu":"0.0","cpu_average":"0","mem":"2.6"},"225":{"cmdline":"frigate.recording_manager","cpu":"1.3","cpu_average":"1","mem":"3.5"},"234":{"cmdline":"/usr/bin/python3 -c from multiprocessing.resource_tracker import main;main(41)","cpu":"0.1","cpu_average":"0","mem":"0.3"},"235":{"cmdline":"frigate.detector.coral","cpu":"0.1","cpu_average":"0","mem":"3.4"},"236":{"cmdline":"frigate.output       ","cpu":"0.2","cpu_average":"0","mem":"3.0"},"242":{"cmdline":"ffmpeg -f rawvideo -pix_fmt yuv420p -video_size 640x480 -i pipe: -f mpegts -s 960x720 -codec:v mpeg1video -q 8 -bf 0 pipe:","cpu":"0.0","cpu_average":"0","mem":"0.6"},"243":{"cmdline":"ffmpeg -f rawvideo -pix_fmt yuv420p -video_size 1280x720 -i pipe: -f mpegts -s 1280x720 -codec:v mpeg1video -q 8 -bf 0 pipe:","cpu":"0.0","cpu_average":"0","mem":"0.5"},"249":{"cmdline":"frigate.process:cam-3","cpu":"0.9","cpu_average":"0","mem":"3.1"},"250":{"cmdline":"frigate.capture:cam-3","cpu":"0.4","cpu_average":"0","mem":"2.8"},"255":{"cmdline":"ffmpeg -hide_banner -loglevel warning -threads 2 -hwaccel_flags allow_profile_mismatch -hwaccel vaapi -hwaccel_device /dev/dri/renderD128 -hwaccel_output_format vaapi -user_agent FFmpeg Frigate/0.13.2-6476f8a -avoid_negative_ts make_zero -fflags +genpts+discardcorrupt -rtsp_transport tcp -timeout 5000000 -use_wallclock_as_timestamps 1 -i rtsp://*:*@cam-ip:554/h264Preview_01_sub -r 5 -vf fps=5,scale_vaapi=w=640:h=480:format=nv12,hwdownload,format=nv12,format=yuv420p -threads 2 -f rawvideo -pix_fmt yuv420p pipe:","cpu":"1.0","cpu_average":"0","mem":"1.3"},"258":{"cmdline":"ffmpeg -hide_banner -loglevel warning -threads 2 -hwaccel_flags allow_profile_mismatch -hwaccel vaapi -hwaccel_device /dev/dri/renderD128 -hwaccel_output_format vaapi -user_agent FFmpeg Frigate/0.13.2-6476f8a -avoid_negative_ts make_zero -fflags +genpts+discardcorrupt -rtsp_transport tcp -timeout 5000000 -use_wallclock_as_timestamps 1 -i rtsp://*:*@cam-ip:554/h264Preview_01_main -f segment -segment_time 10 -segment_format mp4 -reset_timestamps 1 -strftime 1 -c copy /tmp/cache/cam-3@%Y%m%d%H%M%S%z.mp4","cpu":"2.7","cpu_average":"2","mem":"0.7"},"1415":{"cmdline":"sleep 30s","cpu":"0.0","cpu_average":"0","mem":"0.0"}},"detection_fps":1.1,"detectors":{"coral":{"detection_start":0.0,"inference_speed":6.42,"pid":235}},"gpu_usages":{"intel-vaapi":{"gpu":"0.11%","mem":"-%"}},"processes":{"go2rtc":{"pid":90},"logger":{"pid":223},"recording":{"pid":225}},"service":{"last_updated":1714407652,"latest_version":"0.13.2","storage":{"/dev/shm":{"free":62.7,"mount_type":"tmpfs","total":64.0,"used":1.3},"/media/frigate/clips":{"free":29161.3,"mount_type":"ext4","total":38132.3,"used":7384.5},"/media/frigate/recordings":{"free":29161.3,"mount_type":"ext4","total":38132.3,"used":7384.5},"/tmp/cache":{"free":871.3,"mount_type":"tmpfs","total":953.7,"used":82.4}},"temperatures":{"apex_0":73.05},"uptime":1181,"version":"0.13.2-6476f8a"}}

Operating system

Debian

Install method

Docker Compose

Coral version

M.2

Network connection

Wired

Camera make and model

Reolink E1 Zoom

Any other information that may be helpful

I tried to configure an http-flv stream but this camera may not support it. go2rtc crashes without further logs.

Using go2rtc with the rtsp stream from the camera didn't change anything.

I had Frigate running on another server, and it showed similar behavior. Maybe it's how I configured the camera?

It's curious that stuttering occurs only when the event is in progress tho.

Thanks for your support!

Answered by NickM-27

Apr 29, 2024

Could try using udp instead of tcp

View full answer

NickM-27 · 2024-04-29T16:46:36Z

NickM-27
Apr 29, 2024
Collaborator Sponsor

This is likely a camera problem sending buggy audio data (that reencoding fixes) and bad presentation timestamps.

Not sure there is much that can be done other than requesting a fixed firmware from reolink support.

I used to use the reolink e1 pro and it was very buggy

6 replies

ferrarimarco Apr 29, 2024
Author

thanks for the reply.

Is there anything I can try on the Frigate side in terms of input args maybe, while I ping Reolink support?

Thanks!

NickM-27 Apr 29, 2024
Collaborator Sponsor

Could try using udp instead of tcp

Answer selected by ferrarimarco

ferrarimarco Apr 29, 2024
Author

Thanks, I'll try.

Btw, the model is E1 Outdoor, not E1 zoom. My bad.

NickM-27 Apr 29, 2024
Collaborator Sponsor

I'd expect that it supports http-flv, you may want to check that http is enabled in the camera settings

ferrarimarco Apr 30, 2024
Author

I've tried switching to UDP, and it seems to work better. I'll let it run for a few days :)

Thanks for your support!

steveb166 Oct 15, 2024

For anyone else who comes across this - for my E1 Pro - switching to "input_args: preset-rtsp-udp" also seemed to fix the audio delay for me too. I'm also no longer using the restream for recording.

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

[Support]: Recording video stutters and it's not aligned to audio #11159

{{title}}

Replies: 1 comment 6 replies

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

Select a reply

[Support]: Recording video stutters and it's not aligned to audio #11159

ferrarimarco Apr 29, 2024

Describe the problem you are having

Version

Frigate config file

Relevant log output

FFprobe output from your camera

Frigate stats

Operating system

Install method

Coral version

Network connection

Camera make and model

Any other information that may be helpful

Replies: 1 comment · 6 replies

NickM-27 Apr 29, 2024 Collaborator Sponsor

ferrarimarco Apr 29, 2024 Author

NickM-27 Apr 29, 2024 Collaborator Sponsor

ferrarimarco Apr 29, 2024 Author

NickM-27 Apr 29, 2024 Collaborator Sponsor

ferrarimarco Apr 30, 2024 Author

steveb166 Oct 15, 2024

ferrarimarco
Apr 29, 2024

Replies: 1 comment 6 replies

NickM-27
Apr 29, 2024
Collaborator Sponsor

ferrarimarco Apr 29, 2024
Author

NickM-27 Apr 29, 2024
Collaborator Sponsor

ferrarimarco Apr 29, 2024
Author

NickM-27 Apr 29, 2024
Collaborator Sponsor

ferrarimarco Apr 30, 2024
Author