Skip to content

Recording failed; no corresponding WAV file was generated. #2021

@2954456878

Description

@2954456878

rtpengine version the issue has been seen with

Version: 13.5.1.2-1~bpo12+1

Used distribution and its version

Debian 12

Linux kernel version used

6.1.0-40-amd64

CPU architecture issue was seen on (see uname -m)

x86_64

Expected behaviour you didn't see

No response

Unexpected behaviour you saw

This is my configuration file:
output-format = wav
spool-dir = /var/spool/rtpengine
output-dir = /home/call/recording

One out of every 100 calls will fail to generate a recording file.I've enabled debug logging, and this is the error message related to the recording failure:
2025-11-13T08:58:17.496537+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496543+08:00 rtpengine-recording[1261597]: INFO: [core] New call for recording: 'a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta'
2025-11-13T08:58:17.496580+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496589+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496621+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496660+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496673+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496678+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496686+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496723+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496768+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496789+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496827+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.496930+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.497013+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.497228+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.497498+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:17.497583+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:23] inotify close_write(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:51.847198+08:00 rtpengine-recording[1261597]: INFO: [C a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta] [S tag-0-media-1-component-2-RTCP-id-3] [core] EOF on stream tag-0-media-1-component-2-RTCP-id-3
2025-11-13T08:58:51.847215+08:00 rtpengine-recording[1261597]: INFO: [C a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta] [S tag-0-media-1-component-1-RTP-id-2] [core] EOF on stream tag-0-media-1-component-1-RTP-id-2
2025-11-13T08:58:51.847232+08:00 rtpengine-recording[1261597]: INFO: [C a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta] [S tag-1-media-1-component-2-RTCP-id-1] [core] EOF on stream tag-1-media-1-component-2-RTCP-id-1
2025-11-13T08:58:51.847268+08:00 rtpengine-recording[1261597]: INFO: [C a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta] [S tag-1-media-1-component-1-RTP-id-0] [core] EOF on stream tag-1-media-1-component-1-RTP-id-0
2025-11-13T08:58:51.847324+08:00 rtpengine-recording[1261597]: DEBUG: [core] [inotify.c:29] inotify delete(a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta)
2025-11-13T08:58:51.847328+08:00 rtpengine-recording[1261597]: INFO: [core] Recording for call 'a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta' finished
2025-11-13T08:58:54.144143+08:00 rtpengine-recording[1261597]: DEBUG: [core] [metafile.c:29] freeing metafile info for a2088227d63616c6c29db3db2%40192.168.0.1-f17a462ee0ba0317.meta

Compared to normal logs:
Nov 13 11:27:51 ecs-crs-100 rtpengine-recording[2575716]: INFO: [core] New call for recording: '91d3e2e6-3ae3-123f-8c82-fa163eb0c030-7688a37b28f33fad.meta'
Nov 13 11:27:51 ecs-crs-100 rtpengine-recording[2575716]: INFO: [C 91d3e2e6-3ae3-123f-8c82-fa163eb0c030-7688a37b28f33fad.meta] [S tag-0-media-1-component-1-RTP-id-2] [0x8119a0cc] [core] Opened output media file '/home/call/recording/a14ff43d-ae78-406f-93ec-59509b72149b.wav' for writing
Nov 13 11:28:03 ecs-crs-100 rtpengine-recording[2575716]: INFO: [C 91d3e2e6-3ae3-123f-8c82-fa163eb0c030-7688a37b28f33fad.meta] [S tag-0-media-1-component-2-RTCP-id-3] [core] EOF on stream tag-0-media-1-component-2-RTCP-id-3
Nov 13 11:28:03 ecs-crs-100 rtpengine-recording[2575716]: INFO: [C 91d3e2e6-3ae3-123f-8c82-fa163eb0c030-7688a37b28f33fad.meta] [S tag-0-media-1-component-1-RTP-id-2] [core] EOF on stream tag-0-media-1-component-1-RTP-id-2
Nov 13 11:28:03 ecs-crs-100 rtpengine-recording[2575716]: INFO: [C 91d3e2e6-3ae3-123f-8c82-fa163eb0c030-7688a37b28f33fad.meta] [S tag-1-media-1-component-2-RTCP-id-1] [core] EOF on stream tag-1-media-1-component-2-RTCP-id-1
Nov 13 11:28:03 ecs-crs-100 rtpengine-recording[2575716]: INFO: [C 91d3e2e6-3ae3-123f-8c82-fa163eb0c030-7688a37b28f33fad.meta] [S tag-1-media-1-component-1-RTP-id-0] [core] EOF on stream tag-1-media-1-component-1-RTP-id-0
Nov 13 11:28:03 ecs-crs-100 rtpengine-recording[2575716]: INFO: [core] Recording for call '91d3e2e6-3ae3-123f-8c82-fa163eb0c030-7688a37b28f33fad.meta' finished
Nov 13 11:28:03 ecs-crs-100 rtpengine-recording[2575716]: INFO: [core] Closing output media file '/home/call/recording/a14ff43d-ae78-406f-93ec-59509b72149b.wav'

Steps to reproduce the problem

No response

Additional program output to the terminal or logs illustrating the issue

Anything else?

No response

Metadata

Metadata

Assignees

No one assigned

    Labels

    Type

    No type

    Projects

    No projects

    Milestone

    No milestone

    Relationships

    None yet

    Development

    No branches or pull requests

    Issue actions