search

teltek / gst-plugin-ndi

GStreamer NDI Plugin for Linux
GNU Lesser General Public License v2.1
158 stars 27 forks source link

All convert to the same timestamp and the video stuck #63

Closed nanazhan closed 3 years ago

nanazhan commented 3 years ago

0:00:00.010934226 11942 0x5573f56df270 DEBUG ndivideosrc src/ndivideosrc.rs:254:gstndi::ndivideosrc: Changing ndi-name from None to Some("MINI12\ (NDI\ HX\ Camera)") 0:00:00.010952890 11942 0x5573f56df270 DEBUG ndivideosrc src/ndivideosrc.rs:266:gstndi::ndivideosrc: Changing url-address from None to Some("192.168.1.101:5961") 0:00:00.013968847 11942 0x5573f56df270 DEBUG ndivideosrc src/receiver.rs:533:gstndi::receiver: Starting NDI connection... 0:00:00.013981585 11942 0x5573f56df270 DEBUG ndivideosrc src/receiver.rs:583:gstndi::receiver: Connecting to NDI source with NDI name 'Some("MINI12\ (NDI\ HX\ Camera)")' and URL/Address Some("192.168.1.101:5961") 0:00:00.015641303 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.015679982 11942 0x5573f57ed580 FIXME default gstutils.c:4025:gst_pad_create_stream_id_internal: Creating random stream-id, consider implementing a deterministic way of creating a stream-id 0:00:00.065688222 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.115753722 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.165802932 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.215876796 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.265955625 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.316031048 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.366106611 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.416184158 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.466255460 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.516328493 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.566399065 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.616481903 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.666551414 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.716628057 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.766710182 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.816792474 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.866867809 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.916945562 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:00.967029417 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:01.017112691 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:01.067182260 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:01.117246531 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:918:gstndi::receiver: No video frame received yet, retry 0:00:01.121221840 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692460893574 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.121248966 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.089357400, duration 00:00:00.033333333, receive time 00:00:01.105514623, local time now 451713:40:40.545688000 0:00:01.121276824 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.105514623 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.121286582 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.122735599 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f58185a0, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.122800198 11942 0x5573f57ed580 DEBUG ndivideosrc src/ndivideosrc.rs:572:gstndi::ndivideosrc: Configuring for caps video/x-raw, format=(string)UYVY, width=(int)1920, height=(int)1080, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, chroma-site=(string)mpeg2, colorimetry=(string)bt709, framerate=(fraction)30/1 0:00:01.126009730 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692461226907 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.126026828 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.122690700, duration 00:00:00.033333333, receive time 00:00:01.110295990, local time now 451713:40:40.550467000 0:00:01.126036880 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.110295990 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.126043110 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.127241338 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f58186c0, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.133294449 11942 0x5573f57ef980 DEBUG ndivideosrc src/ndivideosrc.rs:505:gstndi::ndivideosrc: Returning latency min 00:00:00.033333333 max 00:00:00.166666665 0:00:01.154736020 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692461560240 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.154763904 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.156024000, duration 00:00:00.033333333, receive time 00:00:01.139032065, local time now 451713:40:40.579204000 0:00:01.154783407 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.139032065 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.154790494 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.156022492 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f58187e0, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.188180214 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692461893573 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.188210147 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.189357300, duration 00:00:00.033333333, receive time 00:00:01.172476975, local time now 451713:40:40.612649000 0:00:01.188222796 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.172476975 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.188230286 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.190004174 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f5818900, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.223983863 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692462226906 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.224020783 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.222690600, duration 00:00:00.033333333, receive time 00:00:01.208287244, local time now 451713:40:40.648459000 0:00:01.224031169 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.208287244 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.224037747 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.224872307 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f5818a20, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.263138758 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692462560239 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.263171015 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.256023900, duration 00:00:00.033333333, receive time 00:00:01.247437954, local time now 451713:40:40.687610000 0:00:01.263179860 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.247437954 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.263184558 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.263833737 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x7f73c4013120, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.296608489 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692462893572 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.296646042 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.289357200, duration 00:00:00.033333333, receive time 00:00:01.280910013, local time now 451713:40:40.721082000 0:00:01.296656086 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.280910013 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.296662103 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.297443563 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x7f73c4013240, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.346348661 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692463226905 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.346381394 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.322690500, duration 00:00:00.033333333, receive time 00:00:01.330647963, local time now 451713:40:40.770820000 0:00:01.346390087 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.330647963 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.346395005 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.347173392 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x7f73c4013360, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.376130629 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692463560238 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.376166885 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.356023800, duration 00:00:00.033333333, receive time 00:00:01.360431218, local time now 451713:40:40.800604000 0:00:01.376176270 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.360431218 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.376181684 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.376984336 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x7f73c4013480, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.399104529 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692463893571 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.399135583 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.389357100, duration 00:00:00.033333333, receive time 00:00:01.383402198, local time now 451713:40:40.823575000 0:00:01.399142587 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.383402198 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.399146669 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.400058915 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x7f73c40135a0, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.448946189 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692464226904 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.448983145 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.422690400, duration 00:00:00.033333333, receive time 00:00:01.433248802, local time now 451713:40:40.873421000 0:00:01.448993195 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.433248802 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.448997848 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.449698132 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f5818a20, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.473876626 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692464560237 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.473907229 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.456023700, duration 00:00:00.033333333, receive time 00:00:01.458173526, local time now 451713:40:40.898346000 0:00:01.473916379 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.458173526 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.473921513 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.474494855 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f5818900, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.516060630 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692464893570 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.516096384 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.489357000, duration 00:00:00.033333333, receive time 00:00:01.500360265, local time now 451713:40:40.940534000 0:00:01.516107827 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.500360265 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.516114433 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.516809990 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f58187e0, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.537749764 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692465226903 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.537797301 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.522690300, duration 00:00:00.033333333, receive time 00:00:01.522060289, local time now 451713:40:40.962234000 0:00:01.537808592 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.522060289 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.537814333 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.538974819 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f58186c0, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.570136168 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692465560236 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.570166257 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.556023600, duration 00:00:00.033333333, receive time 00:00:01.554431772, local time now 451713:40:40.994604000 0:00:01.570177679 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.554431772 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.570184391 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.570796410 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f58185a0, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.603793649 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692465893569 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.603828701 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.589356900, duration 00:00:00.033333333, receive time 00:00:01.588093814, local time now 451713:40:41.028267000 0:00:01.603839423 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.588093814 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.603845786 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.604595458 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x7f73c4013240, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.628189763 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692466226902 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.628225111 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.622690200, duration 00:00:00.033333333, receive time 00:00:01.612490485, local time now 451713:40:41.052663000 0:00:01.628239526 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.612490485 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.628246535 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.629048531 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x7f73c4013120, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.673666532 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692466560235 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.673709941 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.656023500, duration 00:00:00.033333333, receive time 00:00:01.657973022, local time now 451713:40:41.098146000 0:00:01.673722554 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.657973022 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.673728604 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.674520655 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f5818d80, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.709282602 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692466893568 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.709320770 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.689356800, duration 00:00:00.033333333, receive time 00:00:01.693586737, local time now 451713:40:41.133759000 0:00:01.709328940 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.693586737 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.709332990 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.710094176 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f5818ea0, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.731451632 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692467226901 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.731494309 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.722690100, duration 00:00:00.033333333, receive time 00:00:01.715750545, local time now 451713:40:41.155923000 0:00:01.731503728 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.715750545 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.731509189 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.732248691 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x7f73c4013000, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.768816827 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692467560234 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.768847875 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.756023400, duration 00:00:00.033333333, receive time 00:00:01.753114707, local time now 451713:40:41.193287000 0:00:01.768855957 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:318:gstndi::receiver: Converted timestamp 00:00:00.000000000/00:00:01.753114707 to 00:00:01.105514623, duration 00:00:00.033333333 to 00:00:00.033333333 0:00:01.768860026 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:844:gstndi::receiver: Calculated PTS 00:00:01.105514623, duration 00:00:00.033333333 0:00:01.769626428 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:958:gstndi::receiver: Produced buffer Buffer { ptr: 0x5573f5818900, pts: "00:00:01.105514623", dts: "99:99:99.999999999", duration: "00:00:00.033333333", size: 4147200, offset: 18446744073709551615, offset_end: 18446744073709551615, flags: (empty), metas: [GstReferenceTimestampMetaAPI, GstReferenceTimestampMetaAPI] } 0:00:01.792106787 11942 0x7f73c0002400 DEBUG ndivideosrc src/receiver.rs:933:gstndi::receiver: Received video frame BorrowedRecv(NDIlib_video_frame_v2_t { xres: 1920, yres: 1080, FourCC: 1498831189, frame_rate_N: 30, frame_rate_D: 1, picture_aspect_ratio: 1.7777778, frame_format_type: NDIlib_frame_format_type_progressive, timecode: 0, p_data: 0x7f73b6ec9010, line_stride_or_data_size_in_bytes: 3840, p_metadata: 0x0, timestamp: 16261692467893567 }, RecvInstance((RecvInstanceInner(0x5573f55e5400), Mutex { data: (), poisoned: false, .. }))) 0:00:01.792135791 11942 0x7f73c0002400 LOG ndivideosrc src/receiver.rs:803:gstndi::receiver: Received frame with timecode 00:00:00.000000000, timestamp 451713:40:46.789356700, duration 00:00:00.033333333, receive time 00:00:01.776403737, local time now 451713:40:41.216576000

nanazhan commented 3 years ago

I am running this plugin with "NDI HX Camera" installed on iphone, and seems I can only play the first frame and then stuck. From the log, seems the timestamp is not good. Could you please help me look into this issue?

sdroege commented 3 years ago

The NDI HX Camera application is generating wrong timestamps (good work NDI). Instead of generating them in 100ns units, they are generated in 1ns units.

This should not be a problem anymore with the timestamping improvements in git master. It should detect this case and fall back to receive times only.

@samuvlad I think this can be closed for now, it works for me at least.