search

awslabs / amazon-kinesis-video-streams-producer-sdk-cpp

Amazon Kinesis Video Streams Producer SDK for C++ is for developers to install and customize for their connected camera and other devices to securely stream video, audio, and time-encoded data to Kinesis Video Streams.
Apache License 2.0
379 stars 335 forks source link

Unable to Stream RTSP Feed from EZVIZ C3TN Camera to Kinesis Video Stream Using GStreamer #1052

Closed Mr-MeerMoazzam closed 1 year ago

Mr-MeerMoazzam commented 1 year ago

Problem: I'm facing difficulties while attempting to stream a live RTSP feed from an EZVIZ C3TN camera to an Amazon Kinesis Video Stream using GStreamer. The GStreamer pipeline doesn't seem to work as expected, and I'm encountering issues related to receiving UDP packets, linking pads, and internal data stream errors. Add relevent SDK logging. Steps to Reproduce Run the following GStreamer pipeline command to stream the RTSP feed from an EZVIZ C3TN camera to a Kinesis Video Stream:

AWS_ACCESS_KEY_ID=$Access_Key AWS_SECRET_ACCESS_KEY=$Secret_Key AWS_DEFAULT_REGION="us-east-1" gst-launch-1.0 rtspsrc location=rtsp://admin:Password@RTSP/H.264 ! rtph264depay ! h264parse ! kvssink stream-name=camera_148 storage-size=512

Expected Behavior: The GStreamer pipeline should establish a stable connection to the RTSP feed from the EZVIZ C3TN camera, process the H.264 data appropriately, and successfully stream it to the specified Kinesis Video Stream without encountering errors.

Observed Behavior:

-> The pipeline logs display warnings indicating that UDP packets from the RTSP source were not received for a specific duration and that TCP is being used as a fallback. -> Delayed linking failures occur between GstRTSPSrc and GstRtpH264Depay elements. -> The pipeline encounters internal data stream errors and terminates. Additional Information: -> The EZVIZ C3TN camera's live feed has been tested successfully using other RTSP clients, indicating that the camera is operational. -> I've reviewed the firewall settings and there are no indications of the firewall blocking UDP packets. -> The GStreamer plugins for RTSP and H.264 processing are up-to-date. Environment:

Operating System: Ubuntu (20.04) GStreamer Version: (1.16.3)

Logs

[INFO ] [25-08-2023 10:25:40:142.198 GMT] createKinesisVideoClient(): Creating Kinesis Video Client
[INFO ] [25-08-2023 10:25:40:142.231 GMT] heapInitialize(): Initializing native heap with limit size 536870912, spill ratio 0% and flags 0x00000001
[INFO ] [25-08-2023 10:25:40:142.238 GMT] heapInitialize(): Creating AIV heap.
[INFO ] [25-08-2023 10:25:40:142.249 GMT] heapInitialize(): Heap is initialized OK
[DEBUG] [25-08-2023 10:25:40:142.309 GMT] getSecurityTokenHandler invoked
[DEBUG] [25-08-2023 10:25:40:142.318 GMT] Refreshing credentials. Force refreshing: 0 Now time is: 1692959140142317049 Expiration: 0
[INFO ] [25-08-2023 10:25:40:142.328 GMT] createDeviceResultEvent(): Create device result event.
[DEBUG] [25-08-2023 10:25:40:142.336 GMT] clientReadyHandler invoked
[INFO ] [25-08-2023 10:25:40:142.353 GMT] try creating stream
[INFO ] [25-08-2023 10:25:40:142.367 GMT] Creating Kinesis Video Stream camera_148
[INFO ] [25-08-2023 10:25:40:142.375 GMT] createKinesisVideoStream(): Creating Kinesis Video Stream.
[INFO ] [25-08-2023 10:25:40:142.380 GMT] logStreamInfo(): SDK version: e8125ee363c4e77e11b15398a8b77f4e8a5791a5
[DEBUG] [25-08-2023 10:25:40:142.384 GMT] logStreamInfo(): Kinesis Video Stream Info
[DEBUG] [25-08-2023 10:25:40:142.388 GMT] logStreamInfo():  Stream name: camera_148 
[DEBUG] [25-08-2023 10:25:40:142.392 GMT] logStreamInfo():  Streaming type: STREAMING_TYPE_REALTIME 
[DEBUG] [25-08-2023 10:25:40:142.396 GMT] logStreamInfo():  Content type: video/h264 
[DEBUG] [25-08-2023 10:25:40:142.400 GMT] logStreamInfo():  Max latency (100ns): 600000000
[DEBUG] [25-08-2023 10:25:40:142.404 GMT] logStreamInfo():  Fragment duration (100ns): 20000000
[DEBUG] [25-08-2023 10:25:40:142.409 GMT] logStreamInfo():  Key frame fragmentation: Yes
[DEBUG] [25-08-2023 10:25:40:142.413 GMT] logStreamInfo():  Use frame timecode: Yes
[DEBUG] [25-08-2023 10:25:40:142.417 GMT] logStreamInfo():  Absolute frame timecode: Yes
[DEBUG] [25-08-2023 10:25:40:142.422 GMT] logStreamInfo():  Nal adaptation flags: 0
[DEBUG] [25-08-2023 10:25:40:142.426 GMT] logStreamInfo():  Average bandwith (bps): 4194304
[DEBUG] [25-08-2023 10:25:40:142.431 GMT] logStreamInfo():  Framerate: 25
[DEBUG] [25-08-2023 10:25:40:142.435 GMT] logStreamInfo():  Buffer duration (100ns): 1200000000
[DEBUG] [25-08-2023 10:25:40:142.440 GMT] logStreamInfo():  Replay duration (100ns): 400000000
[DEBUG] [25-08-2023 10:25:40:142.444 GMT] logStreamInfo():  Connection Staleness duration (100ns): 600000000
[DEBUG] [25-08-2023 10:25:40:142.447 GMT] logStreamInfo():  Store Pressure Policy: 1
[DEBUG] [25-08-2023 10:25:40:142.451 GMT] logStreamInfo():  View Overflow Policy: 1
[DEBUG] [25-08-2023 10:25:40:142.455 GMT] logStreamInfo():  Segment UUID: NULL
[DEBUG] [25-08-2023 10:25:40:142.459 GMT] logStreamInfo():  Frame ordering mode: 0
[DEBUG] [25-08-2023 10:25:40:142.463 GMT] logStreamInfo(): Track list
[DEBUG] [25-08-2023 10:25:40:142.467 GMT] logStreamInfo():  Track id: 1
[DEBUG] [25-08-2023 10:25:40:142.471 GMT] logStreamInfo():  Track name: kinesis_video
[DEBUG] [25-08-2023 10:25:40:142.475 GMT] logStreamInfo():  Codec id: V_MPEG4/ISO/AVC
[DEBUG] [25-08-2023 10:25:40:142.493 GMT] logStreamInfo():  Track type: TRACK_INFO_TYPE_VIDEO
[DEBUG] [25-08-2023 10:25:40:142.499 GMT] logStreamInfo():  Track cpd: NULL
[INFO ] [25-08-2023 10:25:41:221.875 GMT] writeHeaderCallback(): RequestId: 5bf951a4-9fe6-44de-bb01-67bcaa42b9ae
[DEBUG] [25-08-2023 10:25:41:221.926 GMT] describeStreamCurlHandler(): DescribeStream API response: {"StreamInfo":{"CreationTime":1.692946442192E9,"DataRetentionInHours":8760,"DeviceName":null,"IngestionConfiguration":null,"KmsKeyId":"arn:aws:kms:us-east-1:820417679840:alias/aws/kinesisvideo","MediaType":null,"Status":"ACTIVE","StreamARN":"arn:aws:kinesisvideo:us-east-1:820417679840:stream/camera_148/1692946442192","StreamName":"camera_148","Version":"9RbiPgzmA3cyWwSF8iQQ"}}
[INFO ] [25-08-2023 10:25:41:222.451 GMT] describeStreamResultEvent(): Describe stream result event.
[WARN ] [25-08-2023 10:25:41:222.474 GMT] describeStreamResult(): Retention period returned from the DescribeStream call doesn't match the one specified in the StreamInfo
[WARN ] [25-08-2023 10:25:41:222.504 GMT] describeStreamResult(): Content type returned from the DescribeStream call doesn't match the one specified in the StreamInfo
[INFO ] [25-08-2023 10:25:42:164.694 GMT] writeHeaderCallback(): RequestId: 9db5822c-c4b2-4f6d-8ccf-ea8f5cdbf850
[DEBUG] [25-08-2023 10:25:42:164.725 GMT] getStreamingEndpointCurlHandler(): GetStreamingEndpoint API response: {"DataEndpoint":"https://s-d8eb3b21.kinesisvideo.us-east-1.amazonaws.com"}
[INFO ] [25-08-2023 10:25:42:165.023 GMT] getStreamingEndpointResultEvent(): Get streaming endpoint result event.
[DEBUG] [25-08-2023 10:25:42:165.041 GMT] getStreamingTokenHandler invoked
[DEBUG] [25-08-2023 10:25:42:165.050 GMT] Refreshing credentials. Force refreshing: 1 Now time is: 1692959142165048381 Expiration: 18446744073709551615
[INFO ] [25-08-2023 10:25:42:165.061 GMT] getStreamingTokenResultEvent(): Get streaming token result event.
[DEBUG] [25-08-2023 10:25:42:165.070 GMT] streamReadyHandler invoked
Stream is ready
Pipeline is live and does not need PREROLL ...
Progress: (open) Opening Stream
Progress: (connect) Connecting to rtsp://admin:HPAIWD@203.175.70.148:554/H.264
Progress: (open) Retrieving server options
Progress: (open) Retrieving media info
Progress: (request) SETUP stream 0
Progress: (open) Opened Stream
Setting pipeline to PLAYING ...
New clock: GstSystemClock
Progress: (request) Sending PLAY request
Progress: (request) Sending PLAY request
Progress: (request) Sent PLAY request
WARNING: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Could not read from resource.
Additional debug info:
gstrtspsrc.c(5769): gst_rtspsrc_reconnect (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
Could not receive any UDP packets for 5.0000 seconds, maybe your firewall is blocking it. Retrying using a tcp connection.
WARNING: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Delayed linking failed.
Additional debug info:
./grammar.y(506): gst_parse_no_more_pads (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
failed delayed linking some pad of GstRTSPSrc named rtspsrc0 to some pad of GstRtpH264Depay named rtph264depay0
ERROR: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Internal data stream error.
Additional debug info:
gstrtspsrc.c(6057): gst_rtspsrc_loop (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
streaming stopped, reason not-linked (-1)
Execution ended after 0:00:07.124925275
Setting pipeline to NULL ...
Freeing pipeline ...
[INFO ] [25-08-2023 10:25:49:363.094 GMT] Freeing Kinesis Video Stream camera_148
[INFO ] [25-08-2023 10:25:49:363.148 GMT] freeKinesisVideoStream(): Freeing Kinesis Video stream.
[DEBUG] [25-08-2023 10:25:49:363.179 GMT] curlApiCallbacksShutdownActiveRequests(): pActiveRequests hashtable is empty
[INFO ] [25-08-2023 10:25:49:763.416 GMT] freeKinesisVideoClient(): Freeing Kinesis Video Client
[DEBUG] [25-08-2023 10:25:49:763.456 GMT] curlApiCallbacksShutdownActiveRequests(): pActiveRequests hashtable is empty
[DEBUG] [25-08-2023 10:25:50:163.695 GMT] freeKinesisVideoClientInternal(): Total allocated memory 0
Mr-MeerMoazzam commented 1 year ago

with GST_DEBUG=4 log is

Setting pipeline to PAUSED ...
[INFO ] [25-08-2023 10:25:40:142.198 GMT] createKinesisVideoClient(): Creating Kinesis Video Client
[INFO ] [25-08-2023 10:25:40:142.231 GMT] heapInitialize(): Initializing native heap with limit size 536870912, spill ratio 0% and flags 0x00000001
[INFO ] [25-08-2023 10:25:40:142.238 GMT] heapInitialize(): Creating AIV heap.
[INFO ] [25-08-2023 10:25:40:142.249 GMT] heapInitialize(): Heap is initialized OK
[DEBUG] [25-08-2023 10:25:40:142.309 GMT] getSecurityTokenHandler invoked
[DEBUG] [25-08-2023 10:25:40:142.318 GMT] Refreshing credentials. Force refreshing: 0 Now time is: 1692959140142317049 Expiration: 0
[INFO ] [25-08-2023 10:25:40:142.328 GMT] createDeviceResultEvent(): Create device result event.
[DEBUG] [25-08-2023 10:25:40:142.336 GMT] clientReadyHandler invoked
[INFO ] [25-08-2023 10:25:40:142.353 GMT] try creating stream
[INFO ] [25-08-2023 10:25:40:142.367 GMT] Creating Kinesis Video Stream camera_148
[INFO ] [25-08-2023 10:25:40:142.375 GMT] createKinesisVideoStream(): Creating Kinesis Video Stream.
[INFO ] [25-08-2023 10:25:40:142.380 GMT] logStreamInfo(): SDK version: e8125ee363c4e77e11b15398a8b77f4e8a5791a5
[DEBUG] [25-08-2023 10:25:40:142.384 GMT] logStreamInfo(): Kinesis Video Stream Info
[DEBUG] [25-08-2023 10:25:40:142.388 GMT] logStreamInfo():  Stream name: camera_148 
[DEBUG] [25-08-2023 10:25:40:142.392 GMT] logStreamInfo():  Streaming type: STREAMING_TYPE_REALTIME 
[DEBUG] [25-08-2023 10:25:40:142.396 GMT] logStreamInfo():  Content type: video/h264 
[DEBUG] [25-08-2023 10:25:40:142.400 GMT] logStreamInfo():  Max latency (100ns): 600000000
[DEBUG] [25-08-2023 10:25:40:142.404 GMT] logStreamInfo():  Fragment duration (100ns): 20000000
[DEBUG] [25-08-2023 10:25:40:142.409 GMT] logStreamInfo():  Key frame fragmentation: Yes
[DEBUG] [25-08-2023 10:25:40:142.413 GMT] logStreamInfo():  Use frame timecode: Yes
[DEBUG] [25-08-2023 10:25:40:142.417 GMT] logStreamInfo():  Absolute frame timecode: Yes
[DEBUG] [25-08-2023 10:25:40:142.422 GMT] logStreamInfo():  Nal adaptation flags: 0
[DEBUG] [25-08-2023 10:25:40:142.426 GMT] logStreamInfo():  Average bandwith (bps): 4194304
[DEBUG] [25-08-2023 10:25:40:142.431 GMT] logStreamInfo():  Framerate: 25
[DEBUG] [25-08-2023 10:25:40:142.435 GMT] logStreamInfo():  Buffer duration (100ns): 1200000000
[DEBUG] [25-08-2023 10:25:40:142.440 GMT] logStreamInfo():  Replay duration (100ns): 400000000
[DEBUG] [25-08-2023 10:25:40:142.444 GMT] logStreamInfo():  Connection Staleness duration (100ns): 600000000
[DEBUG] [25-08-2023 10:25:40:142.447 GMT] logStreamInfo():  Store Pressure Policy: 1
[DEBUG] [25-08-2023 10:25:40:142.451 GMT] logStreamInfo():  View Overflow Policy: 1
[DEBUG] [25-08-2023 10:25:40:142.455 GMT] logStreamInfo():  Segment UUID: NULL
[DEBUG] [25-08-2023 10:25:40:142.459 GMT] logStreamInfo():  Frame ordering mode: 0
[DEBUG] [25-08-2023 10:25:40:142.463 GMT] logStreamInfo(): Track list
[DEBUG] [25-08-2023 10:25:40:142.467 GMT] logStreamInfo():  Track id: 1
[DEBUG] [25-08-2023 10:25:40:142.471 GMT] logStreamInfo():  Track name: kinesis_video
[DEBUG] [25-08-2023 10:25:40:142.475 GMT] logStreamInfo():  Codec id: V_MPEG4/ISO/AVC
[DEBUG] [25-08-2023 10:25:40:142.493 GMT] logStreamInfo():  Track type: TRACK_INFO_TYPE_VIDEO
[DEBUG] [25-08-2023 10:25:40:142.499 GMT] logStreamInfo():  Track cpd: NULL
[INFO ] [25-08-2023 10:25:41:221.875 GMT] writeHeaderCallback(): RequestId: 5bf951a4-9fe6-44de-bb01-67bcaa42b9ae
[DEBUG] [25-08-2023 10:25:41:221.926 GMT] describeStreamCurlHandler(): DescribeStream API response: {"StreamInfo":{"CreationTime":1.692946442192E9,"DataRetentionInHours":8760,"DeviceName":null,"IngestionConfiguration":null,"KmsKeyId":"arn:aws:kms:us-east-1:820417679840:alias/aws/kinesisvideo","MediaType":null,"Status":"ACTIVE","StreamARN":"arn:aws:kinesisvideo:us-east-1:820417679840:stream/camera_148/1692946442192","StreamName":"camera_148","Version":"9RbiPgzmA3cyWwSF8iQQ"}}
[INFO ] [25-08-2023 10:25:41:222.451 GMT] describeStreamResultEvent(): Describe stream result event.
[WARN ] [25-08-2023 10:25:41:222.474 GMT] describeStreamResult(): Retention period returned from the DescribeStream call doesn't match the one specified in the StreamInfo
[WARN ] [25-08-2023 10:25:41:222.504 GMT] describeStreamResult(): Content type returned from the DescribeStream call doesn't match the one specified in the StreamInfo
[INFO ] [25-08-2023 10:25:42:164.694 GMT] writeHeaderCallback(): RequestId: 9db5822c-c4b2-4f6d-8ccf-ea8f5cdbf850
[DEBUG] [25-08-2023 10:25:42:164.725 GMT] getStreamingEndpointCurlHandler(): GetStreamingEndpoint API response: {"DataEndpoint":"https://s-d8eb3b21.kinesisvideo.us-east-1.amazonaws.com"}
[INFO ] [25-08-2023 10:25:42:165.023 GMT] getStreamingEndpointResultEvent(): Get streaming endpoint result event.
[DEBUG] [25-08-2023 10:25:42:165.041 GMT] getStreamingTokenHandler invoked
[DEBUG] [25-08-2023 10:25:42:165.050 GMT] Refreshing credentials. Force refreshing: 1 Now time is: 1692959142165048381 Expiration: 18446744073709551615
[INFO ] [25-08-2023 10:25:42:165.061 GMT] getStreamingTokenResultEvent(): Get streaming token result event.
[DEBUG] [25-08-2023 10:25:42:165.070 GMT] streamReadyHandler invoked
Stream is ready
Pipeline is live and does not need PREROLL ...
Progress: (open) Opening Stream
Progress: (connect) Connecting to rtsp://admin:HPAIWD@203.175.70.148:554/H.264
Progress: (open) Retrieving server options
Progress: (open) Retrieving media info
Progress: (request) SETUP stream 0
Progress: (open) Opened Stream
Setting pipeline to PLAYING ...
New clock: GstSystemClock
Progress: (request) Sending PLAY request
Progress: (request) Sending PLAY request
Progress: (request) Sent PLAY request
WARNING: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Could not read from resource.
Additional debug info:
gstrtspsrc.c(5769): gst_rtspsrc_reconnect (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
Could not receive any UDP packets for 5.0000 seconds, maybe your firewall is blocking it. Retrying using a tcp connection.
WARNING: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Delayed linking failed.
Additional debug info:
./grammar.y(506): gst_parse_no_more_pads (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
failed delayed linking some pad of GstRTSPSrc named rtspsrc0 to some pad of GstRtpH264Depay named rtph264depay0
ERROR: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Internal data stream error.
Additional debug info:
gstrtspsrc.c(6057): gst_rtspsrc_loop (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
streaming stopped, reason not-linked (-1)
Execution ended after 0:00:07.124925275
Setting pipeline to NULL ...
Freeing pipeline ...
[INFO ] [25-08-2023 10:25:49:363.094 GMT] Freeing Kinesis Video Stream camera_148
[INFO ] [25-08-2023 10:25:49:363.148 GMT] freeKinesisVideoStream(): Freeing Kinesis Video stream.
[DEBUG] [25-08-2023 10:25:49:363.179 GMT] curlApiCallbacksShutdownActiveRequests(): pActiveRequests hashtable is empty
[INFO ] [25-08-2023 10:25:49:763.416 GMT] freeKinesisVideoClient(): Freeing Kinesis Video Client
[DEBUG] [25-08-2023 10:25:49:763.456 GMT] curlApiCallbacksShutdownActiveRequests(): pActiveRequests hashtable is empty
[DEBUG] [25-08-2023 10:25:50:163.695 GMT] freeKinesisVideoClientInternal(): Total allocated memory 0
[WARN ] [25-08-2023 10:25:50:163.750 GMT] curlApiCallbacksShutdown(): curlApiCallbacksShutdown called when already in progress of shutting down
root@toktoai-B550M-AORUS-ELITE:/home/toktoai/Desktop/moazzam/amazon-kinesis-video-streams-producer-sdk-cpp/build# gst-launch-1.0 --version
gst-launch-1.0 version 1.16.3
GStreamer 1.16.3
https://launchpad.net/distros/ubuntu/+source/gstreamer1.0
root@toktoai-B550M-AORUS-ELITE:/home/toktoai/Desktop/moazzam/amazon-kinesis-video-streams-producer-sdk-cpp/build# AWS_ACCESS_KEY_ID=[REDACTED] AWS_SECRET_ACCESS_KEY=[REDACTED] AWS_DEFAULT_REGION="us-east-1" gst-launch-1.0 rtspsrc location=rtsp://admin:HPAIWD@203.175.70.148:554/H.264 ! rtph264depay ! h264parse ! kvssink stream-name=camera_148 storage-size=512
Setting pipeline to PAUSED ...
[INFO ] [25-08-2023 10:48:00:322.788 GMT] createKinesisVideoClient(): Creating Kinesis Video Client
[INFO ] [25-08-2023 10:48:00:322.824 GMT] heapInitialize(): Initializing native heap with limit size 536870912, spill ratio 0% and flags 0x00000001
[INFO ] [25-08-2023 10:48:00:322.831 GMT] heapInitialize(): Creating AIV heap.
[INFO ] [25-08-2023 10:48:00:322.841 GMT] heapInitialize(): Heap is initialized OK
[DEBUG] [25-08-2023 10:48:00:322.903 GMT] getSecurityTokenHandler invoked
[DEBUG] [25-08-2023 10:48:00:322.914 GMT] Refreshing credentials. Force refreshing: 0 Now time is: 1692960480322911356 Expiration: 0
[INFO ] [25-08-2023 10:48:00:322.928 GMT] createDeviceResultEvent(): Create device result event.
[DEBUG] [25-08-2023 10:48:00:322.940 GMT] clientReadyHandler invoked
[INFO ] [25-08-2023 10:48:00:322.974 GMT] try creating stream
[INFO ] [25-08-2023 10:48:00:322.995 GMT] Creating Kinesis Video Stream camera_148
[INFO ] [25-08-2023 10:48:00:323.007 GMT] createKinesisVideoStream(): Creating Kinesis Video Stream.
[INFO ] [25-08-2023 10:48:00:323.018 GMT] logStreamInfo(): SDK version: e8125ee363c4e77e11b15398a8b77f4e8a5791a5
[DEBUG] [25-08-2023 10:48:00:323.026 GMT] logStreamInfo(): Kinesis Video Stream Info
[DEBUG] [25-08-2023 10:48:00:323.035 GMT] logStreamInfo():  Stream name: camera_148 
[DEBUG] [25-08-2023 10:48:00:323.043 GMT] logStreamInfo():  Streaming type: STREAMING_TYPE_REALTIME 
[DEBUG] [25-08-2023 10:48:00:323.051 GMT] logStreamInfo():  Content type: video/h264 
[DEBUG] [25-08-2023 10:48:00:323.060 GMT] logStreamInfo():  Max latency (100ns): 600000000
[DEBUG] [25-08-2023 10:48:00:323.069 GMT] logStreamInfo():  Fragment duration (100ns): 20000000
[DEBUG] [25-08-2023 10:48:00:323.077 GMT] logStreamInfo():  Key frame fragmentation: Yes
[DEBUG] [25-08-2023 10:48:00:323.085 GMT] logStreamInfo():  Use frame timecode: Yes
[DEBUG] [25-08-2023 10:48:00:323.093 GMT] logStreamInfo():  Absolute frame timecode: Yes
[DEBUG] [25-08-2023 10:48:00:323.102 GMT] logStreamInfo():  Nal adaptation flags: 0
[DEBUG] [25-08-2023 10:48:00:323.110 GMT] logStreamInfo():  Average bandwith (bps): 4194304
[DEBUG] [25-08-2023 10:48:00:323.117 GMT] logStreamInfo():  Framerate: 25
[DEBUG] [25-08-2023 10:48:00:323.126 GMT] logStreamInfo():  Buffer duration (100ns): 1200000000
[DEBUG] [25-08-2023 10:48:00:323.134 GMT] logStreamInfo():  Replay duration (100ns): 400000000
[DEBUG] [25-08-2023 10:48:00:323.142 GMT] logStreamInfo():  Connection Staleness duration (100ns): 600000000
[DEBUG] [25-08-2023 10:48:00:323.149 GMT] logStreamInfo():  Store Pressure Policy: 1
[DEBUG] [25-08-2023 10:48:00:323.157 GMT] logStreamInfo():  View Overflow Policy: 1
[DEBUG] [25-08-2023 10:48:00:323.165 GMT] logStreamInfo():  Segment UUID: NULL
[DEBUG] [25-08-2023 10:48:00:323.172 GMT] logStreamInfo():  Frame ordering mode: 0
[DEBUG] [25-08-2023 10:48:00:323.180 GMT] logStreamInfo(): Track list
[DEBUG] [25-08-2023 10:48:00:323.187 GMT] logStreamInfo():  Track id: 1
[DEBUG] [25-08-2023 10:48:00:323.195 GMT] logStreamInfo():  Track name: kinesis_video
[DEBUG] [25-08-2023 10:48:00:323.202 GMT] logStreamInfo():  Codec id: V_MPEG4/ISO/AVC
[DEBUG] [25-08-2023 10:48:00:323.210 GMT] logStreamInfo():  Track type: TRACK_INFO_TYPE_VIDEO
[DEBUG] [25-08-2023 10:48:00:323.218 GMT] logStreamInfo():  Track cpd: NULL
[INFO ] [25-08-2023 10:48:01:311.935 GMT] writeHeaderCallback(): RequestId: d353e202-84e2-4236-9ca7-0454de1af583
[DEBUG] [25-08-2023 10:48:01:312.004 GMT] describeStreamCurlHandler(): DescribeStream API response: {"StreamInfo":{"CreationTime":1.692946442192E9,"DataRetentionInHours":8760,"DeviceName":null,"IngestionConfiguration":null,"KmsKeyId":"arn:aws:kms:us-east-1:820417679840:alias/aws/kinesisvideo","MediaType":null,"Status":"ACTIVE","StreamARN":"arn:aws:kinesisvideo:us-east-1:820417679840:stream/camera_148/1692946442192","StreamName":"camera_148","Version":"9RbiPgzmA3cyWwSF8iQQ"}}
[INFO ] [25-08-2023 10:48:01:312.705 GMT] describeStreamResultEvent(): Describe stream result event.
[WARN ] [25-08-2023 10:48:01:312.731 GMT] describeStreamResult(): Retention period returned from the DescribeStream call doesn't match the one specified in the StreamInfo
[WARN ] [25-08-2023 10:48:01:312.752 GMT] describeStreamResult(): Content type returned from the DescribeStream call doesn't match the one specified in the StreamInfo
[INFO ] [25-08-2023 10:48:02:202.911 GMT] writeHeaderCallback(): RequestId: ffc586ed-dda8-4ead-acbd-9127e0395328
[DEBUG] [25-08-2023 10:48:02:202.961 GMT] getStreamingEndpointCurlHandler(): GetStreamingEndpoint API response: {"DataEndpoint":"https://s-d8eb3b21.kinesisvideo.us-east-1.amazonaws.com"}
[INFO ] [25-08-2023 10:48:02:203.565 GMT] getStreamingEndpointResultEvent(): Get streaming endpoint result event.
[DEBUG] [25-08-2023 10:48:02:203.589 GMT] getStreamingTokenHandler invoked
[DEBUG] [25-08-2023 10:48:02:203.606 GMT] Refreshing credentials. Force refreshing: 1 Now time is: 1692960482203601739 Expiration: 18446744073709551615
[INFO ] [25-08-2023 10:48:02:203.620 GMT] getStreamingTokenResultEvent(): Get streaming token result event.
[DEBUG] [25-08-2023 10:48:02:203.632 GMT] streamReadyHandler invoked
Stream is ready
Pipeline is live and does not need PREROLL ...
Progress: (open) Opening Stream
Progress: (connect) Connecting to rtsp://admin:HPAIWD@203.175.70.148:554/H.264
Progress: (open) Retrieving server options
Progress: (open) Retrieving media info
Progress: (request) SETUP stream 0
Progress: (open) Opened Stream
Setting pipeline to PLAYING ...
New clock: GstSystemClock
Progress: (request) Sending PLAY request
Progress: (request) Sending PLAY request
Progress: (request) Sent PLAY request
WARNING: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Could not read from resource.
Additional debug info:
gstrtspsrc.c(5769): gst_rtspsrc_reconnect (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
Could not receive any UDP packets for 5.0000 seconds, maybe your firewall is blocking it. Retrying using a tcp connection.
WARNING: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Delayed linking failed.
Additional debug info:
./grammar.y(506): gst_parse_no_more_pads (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
failed delayed linking some pad of GstRTSPSrc named rtspsrc0 to some pad of GstRtpH264Depay named rtph264depay0
ERROR: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Internal data stream error.
Additional debug info:
gstrtspsrc.c(6057): gst_rtspsrc_loop (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
streaming stopped, reason not-linked (-1)
Execution ended after 0:01:19.002674257
Setting pipeline to NULL ...
Freeing pipeline ...
[INFO ] [25-08-2023 10:49:21:275.830 GMT] Freeing Kinesis Video Stream camera_148
[INFO ] [25-08-2023 10:49:21:275.863 GMT] freeKinesisVideoStream(): Freeing Kinesis Video stream.
[DEBUG] [25-08-2023 10:49:21:275.879 GMT] curlApiCallbacksShutdownActiveRequests(): pActiveRequests hashtable is empty
[INFO ] [25-08-2023 10:49:21:676.090 GMT] freeKinesisVideoClient(): Freeing Kinesis Video Client
[DEBUG] [25-08-2023 10:49:21:676.128 GMT] curlApiCallbacksShutdownActiveRequests(): pActiveRequests hashtable is empty
[DEBUG] [25-08-2023 10:49:22:076.330 GMT] freeKinesisVideoClientInternal(): Total allocated memory 0
[WARN ] [25-08-2023 10:49:22:076.359 GMT] curlApiCallbacksShutdown(): curlApiCallbacksShutdown called when already in progress of shutting down
root@toktoai-B550M-AORUS-ELITE:/home/toktoai/Desktop/moazzam/amazon-kinesis-video-streams-producer-sdk-cpp/build# GST_DEBUG=4 AWS_ACCESS_KEY_ID=[REDACTED] AWS_SECRET_ACCESS_KEY=[REDACTED] AWS_DEFAULT_REGION="us-east-1" gst-launch-1.0 rtspsrc location=rtsp://admin:HPAIWD@203.175.70.148:554/H.264 ! rtph264depay ! h264parse ! kvssink stream-name=camera_148 storage-size=512
0:00:00.000050426 230119 0x557ab5d78000 INFO                GST_INIT gst.c:586:init_pre: Initializing GStreamer Core Library version 1.16.3
0:00:00.000078503 230119 0x557ab5d78000 INFO                GST_INIT gst.c:587:init_pre: Using library installed in /usr/lib/x86_64-linux-gnu
0:00:00.000089747 230119 0x557ab5d78000 INFO                GST_INIT gst.c:605:init_pre: Linux toktoai-B550M-AORUS-ELITE 5.15.0-79-generic #86~20.04.2-Ubuntu SMP Mon Jul 17 23:27:17 UTC 2023 x86_64
0:00:00.000259604 230119 0x557ab5d78000 INFO                GST_INIT gstmessage.c:128:_priv_gst_message_initialize: init messages
0:00:00.000564746 230119 0x557ab5d78000 INFO                GST_INIT gstcontext.c:84:_priv_gst_context_initialize: init contexts
0:00:00.000735650 230119 0x557ab5d78000 INFO      GST_PLUGIN_LOADING gstplugin.c:318:_priv_gst_plugin_initialize: registering 0 static plugins
0:00:00.000800604 230119 0x557ab5d78000 INFO      GST_PLUGIN_LOADING gstplugin.c:226:gst_plugin_register_static: registered static plugin "staticelements"
0:00:00.000809194 230119 0x557ab5d78000 INFO      GST_PLUGIN_LOADING gstplugin.c:228:gst_plugin_register_static: added static plugin "staticelements", result: 1
0:00:00.000823791 230119 0x557ab5d78000 INFO            GST_REGISTRY gstregistry.c:1733:ensure_current_registry: reading registry cache: /root/.cache/gstreamer-1.0/registry.x86_64.bin
0:00:00.009995640 230119 0x557ab5d78000 INFO            GST_REGISTRY gstregistrybinary.c:621:priv_gst_registry_binary_read_cache: loaded /root/.cache/gstreamer-1.0/registry.x86_64.bin in 0.009155 seconds
0:00:00.010017082 230119 0x557ab5d78000 INFO            GST_REGISTRY gstregistry.c:1592:scan_and_update_registry: Validating plugins from registry cache: /root/.cache/gstreamer-1.0/registry.x86_64.bin
0:00:00.011304976 230119 0x557ab5d78000 INFO            GST_REGISTRY gstregistry.c:1691:scan_and_update_registry: Registry cache has not changed
0:00:00.011310633 230119 0x557ab5d78000 INFO            GST_REGISTRY gstregistry.c:1768:ensure_current_registry: registry reading and updating done, result = 1
0:00:00.011314405 230119 0x557ab5d78000 INFO                GST_INIT gst.c:806:init_post: GLib runtime version: 2.64.6
0:00:00.011317827 230119 0x557ab5d78000 INFO                GST_INIT gst.c:808:init_post: GLib headers version: 2.64.6
0:00:00.011321110 230119 0x557ab5d78000 INFO                GST_INIT gst.c:810:init_post: initialized GStreamer successfully
0:00:00.011333123 230119 0x557ab5d78000 INFO            GST_PIPELINE gstparse.c:336:gst_parse_launch_full: parsing pipeline description 'rtspsrc location=rtsp://admin:HPAIWD@203.175.70.148:554/H.264 ! rtph264depay ! h264parse ! kvssink stream-name=camera_148 storage-size=512 '
0:00:00.012190439 230119 0x557ab5d78000 INFO      GST_PLUGIN_LOADING gstplugin.c:902:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstrtsp.so" loaded
0:00:00.012198121 230119 0x557ab5d78000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtspsrc"
0:00:00.012758607 230119 0x557ab5d78000 INFO      GST_PLUGIN_LOADING gstplugin.c:902:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstasf.so" loaded
0:00:00.012766220 230119 0x557ab5d78000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtspwms"
0:00:00.012974210 230119 0x557ab5d78000 INFO      GST_PLUGIN_LOADING gstplugin.c:902:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstrealmedia.so" loaded
0:00:00.012979798 230119 0x557ab5d78000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtspreal"
0:00:00.013264476 230119 0x557ab5d78000 INFO      GST_PLUGIN_LOADING gstplugin.c:902:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstrtp.so" loaded
0:00:00.013270552 230119 0x557ab5d78000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtph264depay"
0:00:00.013308127 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRTPBaseDepayload@0x557ab5fec0e0> adding pad 'sink'
0:00:00.013314902 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRTPBaseDepayload@0x557ab5fec0e0> adding pad 'src'
0:00:00.013467019 230119 0x557ab5d78000 INFO      GST_PLUGIN_LOADING gstplugin.c:902:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstvideoparsersbad.so" loaded
0:00:00.013472816 230119 0x557ab5d78000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "h264parse"
0:00:00.013497470 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstBaseParse@0x557ab5ff4460> adding pad 'sink'
0:00:00.013503756 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstBaseParse@0x557ab5ff4460> adding pad 'src'
0:00:00.013512416 230119 0x557ab5d78000 INFO               baseparse gstbaseparse.c:4026:gst_base_parse_set_pts_interpolation:<GstH264Parse@0x557ab5ff4460> PTS interpolation: no
0:00:00.015808556 230119 0x557ab5d78000 INFO      GST_PLUGIN_LOADING gstplugin.c:902:_priv_gst_plugin_load_file_for_registry: plugin "/home/toktoai/Desktop/moazzam/amazon-kinesis-video-streams-producer-sdk-cpp/build/libgstkvssink.so" loaded
0:00:00.015815820 230119 0x557ab5d78000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "kvssink"
0:00:00.015907593 230119 0x557ab5d78000 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "pipeline"
0:00:00.015946565 230119 0x557ab5d78000 INFO            GST_PIPELINE grammar.y:648:gst_parse_perform_link: linking some pad of GstRTSPSrc named rtspsrc0 to some pad of GstRtpH264Depay named rtph264depay0 (0/0) with caps "(NULL)"
0:00:00.015952781 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstutils.c:1771:gst_element_link_pads_full: trying to link element rtspsrc0:(any) to element rtph264depay0:(any)
0:00:00.015965492 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'stream_%u' in element "rtspsrc0"
0:00:00.015971289 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstutils.c:1225:gst_element_get_compatible_pad:<rtspsrc0> Could not find a compatible pad to link to rtph264depay0:sink
0:00:00.015975200 230119 0x557ab5d78000 INFO                 default gstutils.c:2161:gst_element_link_pads_filtered: Could not link pads: rtspsrc0:(null) - rtph264depay0:(null)
0:00:00.015984699 230119 0x557ab5d78000 INFO            GST_PIPELINE grammar.y:648:gst_parse_perform_link: linking some pad of GstRtpH264Depay named rtph264depay0 to some pad of GstH264Parse named h264parse0 (0/0) with caps "(NULL)"
0:00:00.015989867 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstutils.c:1771:gst_element_link_pads_full: trying to link element rtph264depay0:(any) to element h264parse0:(any)
0:00:00.015993639 230119 0x557ab5d78000 INFO                GST_PADS gstutils.c:1034:gst_pad_check_link: trying to link rtph264depay0:src and h264parse0:sink
0:00:00.016000832 230119 0x557ab5d78000 INFO                GST_PADS gstpad.c:4237:gst_pad_peer_query:<h264parse0:src> pad has no peer
0:00:00.016009004 230119 0x557ab5d78000 INFO                GST_PADS gstutils.c:1587:prepare_link_maybe_ghosting: rtph264depay0 and h264parse0 in same bin, no need for ghost pads
0:00:00.016015639 230119 0x557ab5d78000 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtph264depay0:src and h264parse0:sink
0:00:00.016021366 230119 0x557ab5d78000 INFO                GST_PADS gstpad.c:4237:gst_pad_peer_query:<h264parse0:src> pad has no peer
0:00:00.016027023 230119 0x557ab5d78000 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtph264depay0:src and h264parse0:sink, successful
0:00:00.016030376 230119 0x557ab5d78000 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:00.016034217 230119 0x557ab5d78000 INFO               GST_EVENT gstpad.c:5812:gst_pad_send_event_unchecked:<rtph264depay0:src> Received event on flushing pad. Discarding
0:00:00.016042389 230119 0x557ab5d78000 INFO            GST_PIPELINE grammar.y:648:gst_parse_perform_link: linking some pad of GstH264Parse named h264parse0 to some pad of GstKvsSink named kvssink0 (0/0) with caps "(NULL)"
0:00:00.016047068 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstutils.c:1771:gst_element_link_pads_full: trying to link element h264parse0:(any) to element kvssink0:(any)
0:00:00.016061875 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<kvssink0> adding pad 'video_0'
0:00:00.016065227 230119 0x557ab5d78000 INFO                 kvssink gstkvssink.cpp:1243:gst_kvs_sink_request_new_pad: Added new request pad
0:00:00.016069627 230119 0x557ab5d78000 INFO                GST_PADS gstutils.c:1587:prepare_link_maybe_ghosting: h264parse0 and kvssink0 in same bin, no need for ghost pads
0:00:00.016076751 230119 0x557ab5d78000 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link h264parse0:src and kvssink0:video_0
0:00:00.016083316 230119 0x557ab5d78000 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked h264parse0:src and kvssink0:video_0, successful
0:00:00.016087158 230119 0x557ab5d78000 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:00.016090440 230119 0x557ab5d78000 INFO               GST_EVENT gstpad.c:5812:gst_pad_send_event_unchecked:<h264parse0:src> Received event on flushing pad. Discarding
Setting pipeline to PAUSED ...
0:00:00.016107272 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<kvssink0> current NULL pending VOID_PENDING, desired next READY
[INFO ] [25-08-2023 10:58:59:873.412 GMT] createKinesisVideoClient(): Creating Kinesis Video Client
[INFO ] [25-08-2023 10:58:59:873.451 GMT] heapInitialize(): Initializing native heap with limit size 536870912, spill ratio 0% and flags 0x00000001
[INFO ] [25-08-2023 10:58:59:873.458 GMT] heapInitialize(): Creating AIV heap.
[INFO ] [25-08-2023 10:58:59:873.467 GMT] heapInitialize(): Heap is initialized OK
[DEBUG] [25-08-2023 10:58:59:873.535 GMT] getSecurityTokenHandler invoked
[DEBUG] [25-08-2023 10:58:59:873.546 GMT] Refreshing credentials. Force refreshing: 0 Now time is: 1692961139873543593 Expiration: 0
[INFO ] [25-08-2023 10:58:59:873.556 GMT] createDeviceResultEvent(): Create device result event.
[DEBUG] [25-08-2023 10:58:59:873.563 GMT] clientReadyHandler invoked
[INFO ] [25-08-2023 10:58:59:873.580 GMT] try creating stream
[INFO ] [25-08-2023 10:58:59:873.593 GMT] Creating Kinesis Video Stream camera_148
[INFO ] [25-08-2023 10:58:59:873.603 GMT] createKinesisVideoStream(): Creating Kinesis Video Stream.
[INFO ] [25-08-2023 10:58:59:873.608 GMT] logStreamInfo(): SDK version: e8125ee363c4e77e11b15398a8b77f4e8a5791a5
[DEBUG] [25-08-2023 10:58:59:873.614 GMT] logStreamInfo(): Kinesis Video Stream Info
[DEBUG] [25-08-2023 10:58:59:873.618 GMT] logStreamInfo():  Stream name: camera_148 
[DEBUG] [25-08-2023 10:58:59:873.621 GMT] logStreamInfo():  Streaming type: STREAMING_TYPE_REALTIME 
[DEBUG] [25-08-2023 10:58:59:873.625 GMT] logStreamInfo():  Content type: video/h264 
[DEBUG] [25-08-2023 10:58:59:873.632 GMT] logStreamInfo():  Max latency (100ns): 600000000
[DEBUG] [25-08-2023 10:58:59:873.636 GMT] logStreamInfo():  Fragment duration (100ns): 20000000
[DEBUG] [25-08-2023 10:58:59:873.642 GMT] logStreamInfo():  Key frame fragmentation: Yes
[DEBUG] [25-08-2023 10:58:59:873.646 GMT] logStreamInfo():  Use frame timecode: Yes
[DEBUG] [25-08-2023 10:58:59:873.651 GMT] logStreamInfo():  Absolute frame timecode: Yes
[DEBUG] [25-08-2023 10:58:59:873.656 GMT] logStreamInfo():  Nal adaptation flags: 0
[DEBUG] [25-08-2023 10:58:59:873.660 GMT] logStreamInfo():  Average bandwith (bps): 4194304
[DEBUG] [25-08-2023 10:58:59:873.665 GMT] logStreamInfo():  Framerate: 25
[DEBUG] [25-08-2023 10:58:59:873.671 GMT] logStreamInfo():  Buffer duration (100ns): 1200000000
[DEBUG] [25-08-2023 10:58:59:873.677 GMT] logStreamInfo():  Replay duration (100ns): 400000000
[DEBUG] [25-08-2023 10:58:59:873.683 GMT] logStreamInfo():  Connection Staleness duration (100ns): 600000000
[DEBUG] [25-08-2023 10:58:59:873.687 GMT] logStreamInfo():  Store Pressure Policy: 1
[DEBUG] [25-08-2023 10:58:59:873.691 GMT] logStreamInfo():  View Overflow Policy: 1
[DEBUG] [25-08-2023 10:58:59:873.696 GMT] logStreamInfo():  Segment UUID: NULL
[DEBUG] [25-08-2023 10:58:59:873.701 GMT] logStreamInfo():  Frame ordering mode: 0
[DEBUG] [25-08-2023 10:58:59:873.705 GMT] logStreamInfo(): Track list
[DEBUG] [25-08-2023 10:58:59:873.710 GMT] logStreamInfo():  Track id: 1
[DEBUG] [25-08-2023 10:58:59:873.715 GMT] logStreamInfo():  Track name: kinesis_video
[DEBUG] [25-08-2023 10:58:59:873.719 GMT] logStreamInfo():  Codec id: V_MPEG4/ISO/AVC
[DEBUG] [25-08-2023 10:58:59:873.724 GMT] logStreamInfo():  Track type: TRACK_INFO_TYPE_VIDEO
[DEBUG] [25-08-2023 10:58:59:873.729 GMT] logStreamInfo():  Track cpd: NULL
[INFO ] [25-08-2023 10:59:00:822.011 GMT] writeHeaderCallback(): RequestId: 225e4244-bb0b-45a2-89a5-62fa84829b0e
[DEBUG] [25-08-2023 10:59:00:822.061 GMT] describeStreamCurlHandler(): DescribeStream API response: {"StreamInfo":{"CreationTime":1.692946442192E9,"DataRetentionInHours":8760,"DeviceName":null,"IngestionConfiguration":null,"KmsKeyId":"arn:aws:kms:us-east-1:820417679840:alias/aws/kinesisvideo","MediaType":null,"Status":"ACTIVE","StreamARN":"arn:aws:kinesisvideo:us-east-1:820417679840:stream/camera_148/1692946442192","StreamName":"camera_148","Version":"9RbiPgzmA3cyWwSF8iQQ"}}
[INFO ] [25-08-2023 10:59:00:822.384 GMT] describeStreamResultEvent(): Describe stream result event.
[WARN ] [25-08-2023 10:59:00:822.400 GMT] describeStreamResult(): Retention period returned from the DescribeStream call doesn't match the one specified in the StreamInfo
[WARN ] [25-08-2023 10:59:00:822.410 GMT] describeStreamResult(): Content type returned from the DescribeStream call doesn't match the one specified in the StreamInfo
[INFO ] [25-08-2023 10:59:01:716.223 GMT] writeHeaderCallback(): RequestId: 87ccc6bb-a3eb-485e-94fa-8f79ec5b72f5
[DEBUG] [25-08-2023 10:59:01:716.255 GMT] getStreamingEndpointCurlHandler(): GetStreamingEndpoint API response: {"DataEndpoint":"https://s-d8eb3b21.kinesisvideo.us-east-1.amazonaws.com"}
[INFO ] [25-08-2023 10:59:01:716.556 GMT] getStreamingEndpointResultEvent(): Get streaming endpoint result event.
[DEBUG] [25-08-2023 10:59:01:716.577 GMT] getStreamingTokenHandler invoked
[DEBUG] [25-08-2023 10:59:01:716.591 GMT] Refreshing credentials. Force refreshing: 1 Now time is: 1692961141716588207 Expiration: 18446744073709551615
[INFO ] [25-08-2023 10:59:01:716.605 GMT] getStreamingTokenResultEvent(): Get streaming token result event.
[DEBUG] [25-08-2023 10:59:01:716.617 GMT] streamReadyHandler invoked
Stream is ready
0:00:01.859820419 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<kvssink0> completed state change to READY
0:00:01.859831733 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<kvssink0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:01.859855130 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'kvssink0' changed state to 2(READY) successfully
0:00:01.859866584 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<h264parse0> current NULL pending VOID_PENDING, desired next READY
0:00:01.859872870 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<h264parse0> completed state change to READY
0:00:01.859877201 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:01.859883836 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 2(READY) successfully
0:00:01.859889912 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtph264depay0> current NULL pending VOID_PENDING, desired next READY
0:00:01.859894731 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtph264depay0> completed state change to READY
0:00:01.859898502 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtph264depay0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:01.859904299 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'rtph264depay0' changed state to 2(READY) successfully
0:00:01.859911074 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtspsrc0> current NULL pending VOID_PENDING, desired next READY
0:00:01.859932376 230119 0x557ab5d78000 INFO                    task gsttask.c:460:gst_task_set_lock: setting stream lock 0x557ab5fd6fc8 on task 0x557ab5ff04d0
0:00:01.859943970 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtspsrc0> completed state change to READY
0:00:01.859949138 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtspsrc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:01.859955215 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'rtspsrc0' changed state to 2(READY) successfully
0:00:01.859960872 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<pipeline0> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:01.859966110 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed NULL to READY (PAUSED pending)
0:00:01.859980917 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<pipeline0> continue state change READY to PAUSED, final PAUSED
0:00:01.859989298 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<kvssink0> current READY pending VOID_PENDING, desired next PAUSED
0:00:01.860001171 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<kvssink0> completed state change to PAUSED
0:00:01.860006479 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<kvssink0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:01.860012206 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'kvssink0' changed state to 3(PAUSED) successfully
0:00:01.860017933 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<h264parse0> current READY pending VOID_PENDING, desired next PAUSED
0:00:01.860131008 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<h264parse0> completed state change to PAUSED
0:00:01.860137154 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:01.860142811 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 3(PAUSED) successfully
0:00:01.860148538 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtph264depay0> current READY pending VOID_PENDING, desired next PAUSED
0:00:01.860156151 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtph264depay0> completed state change to PAUSED
0:00:01.860161040 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtph264depay0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:01.860167256 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'rtph264depay0' changed state to 3(PAUSED) successfully
0:00:01.860173402 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtspsrc0> current READY pending VOID_PENDING, desired next PAUSED
0:00:01.860207695 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtspsrc0> completed state change to PAUSED
0:00:01.860213282 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtspsrc0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:01.860219428 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2995:gst_bin_change_state_func:<pipeline0> child 'rtspsrc0' changed state to 3(PAUSED) successfully without preroll
0:00:01.860225156 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<pipeline0> completed state change to PAUSED
0:00:01.860229067 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
Pipeline is live and does not need PREROLL ...
Progress: (open) Opening Stream
Progress: (connect) Connecting to rtsp://admin:HPAIWD@203.175.70.148:554/H.264
Progress: (open) Retrieving server options
0:00:01.867269324 230119 0x557ab60530c0 INFO                 rtspsrc gstrtspsrc.c:7788:gst_rtspsrc_retrieve_sdp:<rtspsrc0> Now using version: 1.0
Progress: (open) Retrieving media info
0:00:01.871879414 230119 0x557ab60530c0 INFO      GST_PLUGIN_LOADING gstplugin.c:902:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstudp.so" loaded
0:00:01.871891707 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "udpsrc"
0:00:01.871967067 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstBaseSrc@0x7f150c0c9c70> adding pad 'src'
0:00:01.872012883 230119 0x557ab60530c0 INFO                  udpsrc gstudpsrc.c:1420:gst_udpsrc_open:<udpsrc0> setting udp buffer of 524288 bytes
0:00:01.872021474 230119 0x557ab60530c0 INFO                  udpsrc gstudpsrc.c:1439:gst_udpsrc_open:<udpsrc0> forcibly setting udp buffer of 524288 bytes
0:00:01.872029995 230119 0x557ab60530c0 INFO                  udpsrc gstudpsrc.c:1459:gst_udpsrc_open:<udpsrc0> have udp buffer of 524288 bytes
0:00:01.872044801 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsrc0> completed state change to READY
0:00:01.872052903 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc0> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:01.872077208 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsrc0> completed state change to NULL
0:00:01.872084751 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:01.872095856 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<udpsrc0> 0x7f150c0c9c70 dispose
0:00:01.872103120 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<udpsrc0> removing pad 'src'
0:00:01.872122815 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<udpsrc0> 0x7f150c0c9c70 parent class dispose
0:00:01.872130498 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<udpsrc0> 0x7f150c0c9c70 finalize
0:00:01.872137273 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<udpsrc0> 0x7f150c0c9c70 finalize parent
0:00:01.872194404 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "udpsrc"
0:00:01.872209210 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstBaseSrc@0x7f150c0c9c70> adding pad 'src'
0:00:01.872240639 230119 0x557ab60530c0 INFO                  udpsrc gstudpsrc.c:1420:gst_udpsrc_open:<udpsrc1> setting udp buffer of 524288 bytes
0:00:01.872247763 230119 0x557ab60530c0 INFO                  udpsrc gstudpsrc.c:1439:gst_udpsrc_open:<udpsrc1> forcibly setting udp buffer of 524288 bytes
0:00:01.872255935 230119 0x557ab60530c0 INFO                  udpsrc gstudpsrc.c:1459:gst_udpsrc_open:<udpsrc1> have udp buffer of 524288 bytes
0:00:01.872268367 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsrc1> completed state change to READY
0:00:01.872276399 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc1> notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:01.872333250 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "udpsrc"
0:00:01.872346032 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstBaseSrc@0x7f150c0cc170> adding pad 'src'
0:00:01.872374527 230119 0x557ab60530c0 INFO                  udpsrc gstudpsrc.c:1459:gst_udpsrc_open:<udpsrc2> have udp buffer of 106496 bytes
0:00:01.872386959 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsrc2> completed state change to READY
0:00:01.872394083 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc2> notifying about state-changed NULL to READY (VOID_PENDING pending)
Progress: (request) SETUP stream 0
0:00:01.876063535 230119 0x557ab60530c0 INFO      GST_PLUGIN_LOADING gstplugin.c:902:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstrtpmanager.so" loaded
0:00:01.876074081 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:360:gst_element_factory_create: creating element "rtpbin" named "manager"
0:00:01.876223055 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<manager> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:01.876230319 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed NULL to READY (PAUSED pending)
0:00:01.876247361 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<manager> continue state change READY to PAUSED, final PAUSED
0:00:01.876256999 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<manager> completed state change to PAUSED
0:00:01.876266567 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:01.876310219 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'recv_rtp_sink_0' in element "manager"
0:00:01.876319927 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtpsession"
0:00:01.876467644 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtpssrcdemux"
0:00:01.876505708 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpSsrcDemux@0x557ab5fca9d0> adding pad 'sink'
0:00:01.876517790 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpSsrcDemux@0x557ab5fca9d0> adding pad 'rtcp_sink'
0:00:01.876527219 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtpstorage"
0:00:01.876565702 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpStorage@0x557ab5ff05a0> adding pad 'src'
0:00:01.876571988 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpStorage@0x557ab5ff05a0> adding pad 'sink'
0:00:01.876620529 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<rtpssrcdemux0> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:01.876627024 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux0> notifying about state-changed NULL to READY (PAUSED pending)
0:00:01.876639805 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<rtpssrcdemux0> continue state change READY to PAUSED, final PAUSED
0:00:01.876649024 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux0> completed state change to PAUSED
0:00:01.876654682 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:01.876664180 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<rtpsession0> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:01.876669837 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession0> notifying about state-changed NULL to READY (PAUSED pending)
0:00:01.876680942 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<rtpsession0> continue state change READY to PAUSED, final PAUSED
0:00:01.876687996 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession0> completed state change to PAUSED
0:00:01.876696098 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:01.876710556 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<rtpstorage0> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:01.876717610 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage0> notifying about state-changed NULL to READY (PAUSED pending)
0:00:01.876731858 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<rtpstorage0> continue state change READY to PAUSED, final PAUSED
0:00:01.876740099 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage0> completed state change to PAUSED
0:00:01.876747223 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage0> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:01.876760004 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'recv_rtp_sink' in element "rtpsession0"
0:00:01.876776347 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpsession0> adding pad 'recv_rtp_sink'
0:00:01.876790525 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpsession0> adding pad 'recv_rtp_src'
0:00:01.876821465 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link recv_rtp_sink_0:proxypad0 and rtpsession0:recv_rtp_sink
0:00:01.876829637 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked recv_rtp_sink_0:proxypad0 and rtpsession0:recv_rtp_sink, successful
0:00:01.876836412 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:01.876849612 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<manager> adding pad 'recv_rtp_sink_0'
0:00:01.876858133 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpsession0:recv_rtp_src
0:00:01.876863790 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpstorage0:sink
0:00:01.876873847 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpsession0:recv_rtp_src and rtpstorage0:sink
0:00:01.876885581 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:4237:gst_pad_peer_query:<rtpstorage0:src> pad has no peer
0:00:01.876895079 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpsession0:recv_rtp_src and rtpstorage0:sink, successful
0:00:01.876900806 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:01.876913727 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpstorage0:src
0:00:01.876919384 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpssrcdemux0:sink
0:00:01.876928953 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpstorage0:src and rtpssrcdemux0:sink
0:00:01.876937124 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpstorage0:src and rtpssrcdemux0:sink, successful
0:00:01.876942852 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:01.876958496 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'recv_rtcp_sink_0' in element "manager"
0:00:01.876966738 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'recv_rtcp_sink' in element "rtpsession0"
0:00:01.876982801 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpsession0> adding pad 'recv_rtcp_sink'
0:00:01.876996281 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpsession0> adding pad 'sync_src'
0:00:01.877006688 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpsession0:sync_src
0:00:01.877012415 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpssrcdemux0:rtcp_sink
0:00:01.877022402 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpsession0:sync_src and rtpssrcdemux0:rtcp_sink
0:00:01.877029666 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpsession0:sync_src and rtpssrcdemux0:rtcp_sink, successful
0:00:01.877035812 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:01.877054390 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link recv_rtcp_sink_0:proxypad1 and rtpsession0:recv_rtcp_sink
0:00:01.877061165 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked recv_rtcp_sink_0:proxypad1 and rtpsession0:recv_rtcp_sink, successful
0:00:01.877067800 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:01.877077647 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<manager> adding pad 'recv_rtcp_sink_0'
0:00:01.877088263 230119 0x557ab60530c0 INFO                 rtspsrc gstrtspsrc.c:3953:gst_rtspsrc_stream_configure_manager:<rtspsrc0> configure bandwidth in session 0x7f150c0e0090
0:00:01.877096435 230119 0x557ab60530c0 INFO                 rtspsrc gstrtspsrc.c:3958:gst_rtspsrc_stream_configure_manager:<rtspsrc0> setting AS: 5000000.000000
0:00:01.877117178 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad udpsrc1:src
0:00:01.877127236 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link udpsrc1:src and manager:recv_rtp_sink_0
0:00:01.877132893 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked udpsrc1:src and manager:recv_rtp_sink_0, successful
0:00:01.877137502 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:01.877142671 230119 0x557ab60530c0 INFO               GST_EVENT gstpad.c:5812:gst_pad_send_event_unchecked:<udpsrc1:src> Received event on flushing pad. Discarding
0:00:01.877155592 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad udpsrc2:src
0:00:01.877162855 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link udpsrc2:src and manager:recv_rtcp_sink_0
0:00:01.877168093 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked udpsrc2:src and manager:recv_rtcp_sink_0, successful
0:00:01.877171376 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:01.877175567 230119 0x557ab60530c0 INFO               GST_EVENT gstpad.c:5812:gst_pad_send_event_unchecked:<udpsrc2:src> Received event on flushing pad. Discarding
0:00:01.877228088 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "udpsink"
0:00:01.877304356 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstBaseSink@0x7f150c01ede0> adding pad 'sink'
0:00:01.877610475 230119 0x557ab60530c0 INFO      GST_PLUGIN_LOADING gstplugin.c:902:_priv_gst_plugin_load_file_for_registry: plugin "/usr/lib/x86_64-linux-gnu/gstreamer-1.0/libgstcoreelements.so" loaded
0:00:01.877618926 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "fakesrc"
0:00:01.877688210 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstBaseSrc@0x7f150c026180> adding pad 'src'
0:00:01.877711677 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstutils.c:1771:gst_element_link_pads_full: trying to link element fakesrc0:src to element udpsink0:sink
0:00:01.877717334 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad fakesrc0:src
0:00:01.877722014 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad udpsink0:sink
0:00:01.877729277 230119 0x557ab60530c0 INFO                GST_PADS gstutils.c:1587:prepare_link_maybe_ghosting: fakesrc0 and udpsink0 in same bin, no need for ghost pads
0:00:01.877741220 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link fakesrc0:src and udpsink0:sink
0:00:01.877749741 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked fakesrc0:src and udpsink0:sink, successful
0:00:01.877756865 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:01.877763640 230119 0x557ab60530c0 INFO               GST_EVENT gstpad.c:5812:gst_pad_send_event_unchecked:<fakesrc0:src> Received event on flushing pad. Discarding
0:00:01.877819374 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "udpsink"
0:00:01.877833762 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstBaseSink@0x7f150c024c80> adding pad 'sink'
0:00:01.877876505 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsink1> committing state from NULL to READY, pending PLAYING, next PAUSED
0:00:01.877884258 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink1> notifying about state-changed NULL to READY (PLAYING pending)
0:00:01.877894385 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsink1> continue state change READY to PAUSED, final PLAYING
0:00:01.877905630 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsink1> committing state from READY to PAUSED, pending PLAYING, next PLAYING
0:00:01.877912684 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink1> notifying about state-changed READY to PAUSED (PLAYING pending)
0:00:01.877922741 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsink1> continue state change PAUSED to PLAYING, final PLAYING
0:00:01.877928957 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsink1> completed state change to PLAYING
0:00:01.877937827 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink1> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.877952075 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad udpsink1:sink
0:00:01.877959757 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'send_rtcp_src_0' in element "manager"
0:00:01.877969326 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'send_rtcp_src' in element "rtpsession0"
0:00:01.877986437 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpsession0> adding pad 'send_rtcp_src'
0:00:01.878006901 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpsession0:send_rtcp_src and send_rtcp_src_0:proxypad2
0:00:01.878013047 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpsession0:send_rtcp_src and send_rtcp_src_0:proxypad2, successful
0:00:01.878018355 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:01.878029809 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<manager> adding pad 'send_rtcp_src_0'
0:00:01.878042172 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link manager:send_rtcp_src_0 and udpsink1:sink
0:00:01.878049365 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked manager:send_rtcp_src_0 and udpsink1:sink, successful
0:00:01.878055651 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
Progress: (open) Opened Stream
Setting pipeline to PLAYING ...
0:00:01.878131779 230119 0x557ab5d78000 INFO               GST_EVENT gstevent.c:1449:gst_event_new_latency: creating latency event 0:00:00.000000000
0:00:01.878143792 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:1827:gst_element_default_send_event: can't send latency event on element kvssink0
0:00:01.878153850 230119 0x557ab5d78000 WARN                     bin gstbin.c:2786:gst_bin_do_latency_func:<pipeline0> did not really configure latency of 0:00:00.000000000
0:00:01.878165164 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<kvssink0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:01.878182275 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<kvssink0> completed state change to PLAYING
0:00:01.878187514 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<kvssink0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.878195895 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'kvssink0' changed state to 4(PLAYING) successfully
0:00:01.878203019 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<h264parse0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:01.878207279 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<h264parse0> completed state change to PLAYING
0:00:01.878212587 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.878219292 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 4(PLAYING) successfully
0:00:01.878226416 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtph264depay0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:01.878231584 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtph264depay0> completed state change to PLAYING
0:00:01.878236822 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtph264depay0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.878243597 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'rtph264depay0' changed state to 4(PLAYING) successfully
0:00:01.878271674 230119 0x557ab60530c0 INFO                    task gsttask.c:312:gst_task_func:<task0> Task going to paused
0:00:01.878281731 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<rtspsrc0> child 'udpsink1' changed state to 4(PLAYING) successfully
0:00:01.878288366 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<rtspsrc0> child 'udpsink0' changed state to 4(PLAYING) successfully
0:00:01.878294093 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<rtspsrc0> child 'manager' changed state to 4(PLAYING) successfully
0:00:01.878299750 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<rtspsrc0> child 'fakesrc0' changed state to 4(PLAYING) successfully
0:00:01.878305058 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<rtspsrc0> child 'udpsrc1' changed state to 4(PLAYING) successfully
0:00:01.878309947 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<rtspsrc0> child 'udpsrc2' changed state to 4(PLAYING) successfully
0:00:01.878318887 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtspsrc0> completed state change to PLAYING
0:00:01.878323706 230119 0x557ab60530c0 INFO                    task gsttask.c:314:gst_task_func:<task0> Task resume from paused
0:00:01.878324614 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtspsrc0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.878333205 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsink0> completed state change to NULL
0:00:01.878338024 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<fakesrc0> completed state change to NULL
0:00:01.878338024 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'rtspsrc0' changed state to 4(PLAYING) successfully
0:00:01.878348012 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<pipeline0> completed state change to PLAYING
0:00:01.878355136 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.878348012 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsink0> committing state from NULL to READY, pending PLAYING, next PAUSED
0:00:01.878368545 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink0> notifying about state-changed NULL to READY (PLAYING pending)
0:00:01.878379022 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsink0> continue state change READY to PAUSED, final PLAYING
New clock: GstSystemClock
0:00:01.878389498 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsink0> committing state from READY to PAUSED, pending PLAYING, next PLAYING
0:00:01.878395644 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink0> notifying about state-changed READY to PAUSED (PLAYING pending)
Progress: (request) Sending PLAY request
0:00:01.878405771 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsink0> continue state change PAUSED to PLAYING, final PLAYING
0:00:01.878413803 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsink0> completed state change to PLAYING
0:00:01.878421835 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.878435873 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<fakesrc0> committing state from NULL to READY, pending PLAYING, next PAUSED
0:00:01.878441600 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<fakesrc0> notifying about state-changed NULL to READY (PLAYING pending)
0:00:01.878453753 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<fakesrc0> continue state change READY to PAUSED, final PLAYING
0:00:01.878466604 230119 0x557ab60530c0 INFO                 basesrc gstbasesrc.c:1373:gst_base_src_do_seek:<fakesrc0> seeking: bytes segment start=0, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
0:00:01.878479106 230119 0x557ab60530c0 INFO                    task gsttask.c:460:gst_task_set_lock: setting stream lock 0x7f150c015020 on task 0x557ab5ff0710
0:00:01.878485182 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:6159:gst_pad_start_task:<fakesrc0:src> created task 0x557ab5ff0710
0:00:01.878538681 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<fakesrc0> committing state from READY to PAUSED, pending PLAYING, next PLAYING
0:00:01.878548180 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<fakesrc0> notifying about state-changed READY to PAUSED (PLAYING pending)
0:00:01.878562009 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<fakesrc0> continue state change PAUSED to PLAYING, final PLAYING
0:00:01.878567806 230119 0x7f150c0c1360 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'sink' in element "fakesrc0"
0:00:01.878584358 230119 0x7f150c0c1360 FIXME                default gstutils.c:3980:gst_pad_create_stream_id_internal:<fakesrc0:src> Creating random stream-id, consider implementing a deterministic way of creating a stream-id
0:00:01.878588689 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<fakesrc0> completed state change to PLAYING
0:00:01.878596441 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<fakesrc0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.878616346 230119 0x7f150c0c1360 INFO               GST_EVENT gstevent.c:900:gst_event_new_segment: creating segment event bytes segment start=0, offset=0, stop=-1, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0, base=0, position 0, duration -1
Progress: (request) Sending PLAY request
0:00:01.878625915 230119 0x7f150c0c1360 INFO                 basesrc gstbasesrc.c:2962:gst_base_src_loop:<fakesrc0> marking pending DISCONT
0:00:01.878684024 230119 0x7f150c0c1360 INFO                 basesrc gstbasesrc.c:2853:gst_base_src_loop:<fakesrc0> pausing after gst_base_src_get_range() = eos
0:00:01.878690868 230119 0x7f150c0c1360 INFO                    task gsttask.c:312:gst_task_func:<fakesrc0:src> Task going to paused
0:00:01.880710851 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpssrcdemux0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:01.880719302 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux0> completed state change to PLAYING
0:00:01.880726007 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.880741861 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpssrcdemux0' changed state to 4(PLAYING) successfully
0:00:01.880750312 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpstorage0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:01.880756947 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage0> completed state change to PLAYING
0:00:01.880766027 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.880779436 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpstorage0' changed state to 4(PLAYING) successfully
0:00:01.880787398 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpsession0> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:01.880825532 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession0> completed state change to PLAYING
0:00:01.880833634 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.880848301 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpsession0' changed state to 4(PLAYING) successfully
0:00:01.880855355 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<manager> completed state change to PLAYING
0:00:01.880863387 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.880881616 230119 0x557ab60530c0 INFO                 basesrc gstbasesrc.c:1373:gst_base_src_do_seek:<udpsrc1> seeking: time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:01.880894886 230119 0x557ab60530c0 INFO                    task gsttask.c:460:gst_task_set_lock: setting stream lock 0x557ab5fef680 on task 0x557ab5ff0830
0:00:01.880900683 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:6159:gst_pad_start_task:<udpsrc1:src> created task 0x557ab5ff0830
0:00:01.880941680 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsrc1> committing state from READY to PAUSED, pending PLAYING, next PLAYING
0:00:01.880949782 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc1> notifying about state-changed READY to PAUSED (PLAYING pending)
0:00:01.880964170 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsrc1> continue state change PAUSED to PLAYING, final PLAYING
0:00:01.880973598 230119 0x7f150c0c18c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'sink' in element "udpsrc1"
0:00:01.880994691 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsrc1> completed state change to PLAYING
0:00:01.881000418 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc1> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.881016971 230119 0x557ab60530c0 INFO                 basesrc gstbasesrc.c:1373:gst_base_src_do_seek:<udpsrc2> seeking: time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:01.881034711 230119 0x557ab60530c0 INFO                    task gsttask.c:460:gst_task_set_lock: setting stream lock 0x557ab5fef8d0 on task 0x557ab5ff0950
0:00:01.881040298 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:6159:gst_pad_start_task:<udpsrc2:src> created task 0x557ab5ff0950
0:00:01.881065302 230119 0x7f150c0c18c0 INFO               GST_EVENT gstevent.c:820:gst_event_new_caps: creating caps event application/x-rtp, media=(string)video, payload=(int)96, clock-rate=(int)90000, encoding-name=(string)H265, profile-level-id=(string)420029, packetization-mode=(string)1, sprop-parameter-sets=(string)"QgEBAWAAAAMAAAMAAAMAAAMAeKADwIARB8uNrkk5TNxEMyIRAAAAAHAAAAAA\,RAHA8vAiQA\=\=", a-Media_header=(string)"MEDIAINFO\=494D4B48010100000400050000000000000000000000000000000000000000000000000000000000\;", a-appversion=(string)1.0, ssrc=(uint)634707547, clock-base=(uint)758147057, seqnum-base=(uint)55044, npt-start=(guint64)0, play-speed=(double)1, play-scale=(double)1
0:00:01.881094146 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsrc2> committing state from READY to PAUSED, pending PLAYING, next PLAYING
0:00:01.881102178 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc2> notifying about state-changed READY to PAUSED (PLAYING pending)
0:00:01.881114820 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsrc2> continue state change PAUSED to PLAYING, final PLAYING
0:00:01.881122014 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsrc2> completed state change to PLAYING
0:00:01.881131163 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc2> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:01.881159309 230119 0x7f150c0c1920 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'sink' in element "udpsrc2"
Progress: (request) Sent PLAY request
0:00:01.881196466 230119 0x7f150c0c1920 INFO               GST_EVENT gstevent.c:820:gst_event_new_caps: creating caps event application/x-rtcp
0:00:06.885775020 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpssrcdemux0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:06.885798836 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux0> completed state change to PAUSED
0:00:06.885812106 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:06.885844793 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpssrcdemux0' changed state to 3(PAUSED) successfully
0:00:06.885858691 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpstorage0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:06.885869587 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage0> completed state change to PAUSED
0:00:06.885881600 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:06.885899130 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpstorage0' changed state to 3(PAUSED) successfully
0:00:06.885912610 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpsession0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:06.885927835 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession0> completed state change to PAUSED
0:00:06.885940128 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:06.885957798 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpsession0' changed state to 3(PAUSED) successfully
0:00:06.885970649 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<manager> committing state from PLAYING to PAUSED, pending READY, next READY
0:00:06.885983151 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed PLAYING to PAUSED (READY pending)
0:00:06.885999284 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<manager> continue state change PAUSED to READY, final READY
0:00:06.886018840 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpssrcdemux0> current PAUSED pending VOID_PENDING, desired next READY
0:00:06.886041818 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux0> completed state change to READY
0:00:06.886050758 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:06.886068009 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpssrcdemux0' changed state to 2(READY) successfully
0:00:06.886085540 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpstorage0> current PAUSED pending VOID_PENDING, desired next READY
0:00:06.886101673 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage0> completed state change to READY
0:00:06.886110404 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:06.886126956 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpstorage0' changed state to 2(READY) successfully
0:00:06.886137502 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpsession0> current PAUSED pending VOID_PENDING, desired next READY
0:00:06.886165090 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession0> completed state change to READY
0:00:06.886174240 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:06.886190862 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpsession0' changed state to 2(READY) successfully
0:00:06.886210418 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<manager> completed state change to READY
0:00:06.886219916 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:06.886239123 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsrc1> committing state from PLAYING to PAUSED, pending READY, next READY
0:00:06.886248552 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc1> notifying about state-changed PLAYING to PAUSED (READY pending)
0:00:06.886263917 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsrc1> continue state change PAUSED to READY, final READY
0:00:06.886299677 230119 0x7f150c0c18c0 INFO                 basesrc gstbasesrc.c:2853:gst_base_src_loop:<udpsrc1> pausing after gst_base_src_get_range() = flushing
0:00:06.886375595 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsrc1> completed state change to READY
0:00:06.886386910 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc1> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:06.886407513 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsrc2> committing state from PLAYING to PAUSED, pending READY, next READY
0:00:06.886416034 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc2> notifying about state-changed PLAYING to PAUSED (READY pending)
0:00:06.886431399 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsrc2> continue state change PAUSED to READY, final READY
0:00:06.886467578 230119 0x7f150c0c1920 INFO                 basesrc gstbasesrc.c:2853:gst_base_src_loop:<udpsrc2> pausing after gst_base_src_get_range() = flushing
0:00:06.886525407 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsrc2> completed state change to READY
0:00:06.886536233 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc2> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:06.889240463 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsrc1> completed state change to NULL
0:00:06.889255968 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:06.889280831 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking udpsrc1:src(0x557ab5fef610) and manager:recv_rtp_sink_0(0x7f150c0181b0)
0:00:06.889295009 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked udpsrc1:src and manager:recv_rtp_sink_0
0:00:06.889307511 230119 0x557ab60530c0 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<rtspsrc0> removed child "udpsrc1"
0:00:06.889325042 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<udpsrc1> 0x7f150c0c9c70 dispose
0:00:06.889333632 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<udpsrc1> removing pad 'src'
0:00:06.889349906 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<udpsrc1> 0x7f150c0c9c70 parent class dispose
0:00:06.889364153 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<udpsrc1> 0x7f150c0c9c70 finalize
0:00:06.889370928 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<udpsrc1> 0x7f150c0c9c70 finalize parent
0:00:06.889393697 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsink0> committing state from PLAYING to PAUSED, pending NULL, next READY
0:00:06.889402916 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink0> notifying about state-changed PLAYING to PAUSED (NULL pending)
0:00:06.889430504 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsink0> continue state change PAUSED to READY, final NULL
0:00:06.889451457 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsink0> committing state from PAUSED to READY, pending NULL, next NULL
0:00:06.889458580 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink0> notifying about state-changed PAUSED to READY (NULL pending)
0:00:06.889468708 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsink0> continue state change READY to NULL, final NULL
0:00:06.889476181 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsink0> completed state change to NULL
0:00:06.889482816 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:06.889495876 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking fakesrc0:src(0x7f150c014fb0) and udpsink0:sink(0x7f150c014d60)
0:00:06.889506772 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked fakesrc0:src and udpsink0:sink
0:00:06.889518086 230119 0x557ab60530c0 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<rtspsrc0> removed child "udpsink0"
0:00:06.889531915 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<udpsink0> 0x7f150c01ede0 dispose
0:00:06.889539877 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<udpsink0> removing pad 'sink'
0:00:06.889552588 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<udpsink0> 0x7f150c01ede0 parent class dispose
0:00:06.889569420 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<udpsink0> 0x7f150c01ede0 finalize
0:00:06.889576963 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<udpsink0> 0x7f150c01ede0 finalize parent
0:00:06.889595681 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsrc2> completed state change to NULL
0:00:06.889606577 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsrc2> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:06.889637098 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking udpsrc2:src(0x557ab5fef860) and manager:recv_rtcp_sink_0(0x7f150c018430)
0:00:06.889649879 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked udpsrc2:src and manager:recv_rtcp_sink_0
0:00:06.889664755 230119 0x557ab60530c0 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<rtspsrc0> removed child "udpsrc2"
0:00:06.889683822 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<udpsrc2> 0x7f150c0cc170 dispose
0:00:06.889690597 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<udpsrc2> removing pad 'src'
0:00:06.889701423 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<udpsrc2> 0x7f150c0cc170 parent class dispose
0:00:06.889712388 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<udpsrc2> 0x7f150c0cc170 finalize
0:00:06.889723493 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<udpsrc2> 0x7f150c0cc170 finalize parent
0:00:06.889748706 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsink1> committing state from PLAYING to PAUSED, pending NULL, next READY
0:00:06.889755900 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink1> notifying about state-changed PLAYING to PAUSED (NULL pending)
0:00:06.889766655 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsink1> continue state change PAUSED to READY, final NULL
0:00:06.889781881 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<udpsink1> committing state from PAUSED to READY, pending NULL, next NULL
0:00:06.889789075 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink1> notifying about state-changed PAUSED to READY (NULL pending)
0:00:06.889799342 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<udpsink1> continue state change READY to NULL, final NULL
0:00:06.889805977 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<udpsink1> completed state change to NULL
0:00:06.889812612 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<udpsink1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:06.889825114 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking manager:send_rtcp_src_0(0x7f150c0186b0) and udpsink1:sink(0x7f150c015200)
0:00:06.889834612 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked manager:send_rtcp_src_0 and udpsink1:sink
0:00:06.889843133 230119 0x557ab60530c0 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<rtspsrc0> removed child "udpsink1"
0:00:06.889851863 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<udpsink1> 0x7f150c024c80 dispose
0:00:06.889858009 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<udpsink1> removing pad 'sink'
0:00:06.889867019 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<udpsink1> 0x7f150c024c80 parent class dispose
0:00:06.889884759 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<udpsink1> 0x7f150c024c80 finalize
0:00:06.889891813 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<udpsink1> 0x7f150c024c80 finalize parent
0:00:06.889904664 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<fakesrc0> committing state from PLAYING to PAUSED, pending NULL, next READY
0:00:06.889911928 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<fakesrc0> notifying about state-changed PLAYING to PAUSED (NULL pending)
0:00:06.889922823 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<fakesrc0> continue state change PAUSED to READY, final NULL
0:00:06.889967173 230119 0x7f150c0c1360 INFO                    task gsttask.c:314:gst_task_func:<fakesrc0:src> Task resume from paused
0:00:06.890013060 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<fakesrc0> committing state from PAUSED to READY, pending NULL, next NULL
0:00:06.890020533 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<fakesrc0> notifying about state-changed PAUSED to READY (NULL pending)
0:00:06.890030939 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<fakesrc0> continue state change READY to NULL, final NULL
0:00:06.890038063 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<fakesrc0> completed state change to NULL
0:00:06.890044279 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<fakesrc0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:06.890057898 230119 0x557ab60530c0 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<rtspsrc0> removed child "fakesrc0"
0:00:06.890080807 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<fakesrc0> 0x7f150c026180 dispose
0:00:06.890087512 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<fakesrc0> removing pad 'src'
0:00:06.890098407 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<fakesrc0> 0x7f150c026180 parent class dispose
0:00:06.890108045 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<fakesrc0> 0x7f150c026180 finalize
0:00:06.890118033 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<fakesrc0> 0x7f150c026180 finalize parent
0:00:06.890140452 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpssrcdemux0> current READY pending VOID_PENDING, desired next NULL
0:00:06.890150929 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux0> completed state change to NULL
0:00:06.890161335 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:06.890179005 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpssrcdemux0' changed state to 1(NULL) successfully
0:00:06.890190878 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpstorage0> current READY pending VOID_PENDING, desired next NULL
0:00:06.890202472 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage0> completed state change to NULL
0:00:06.890211901 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:06.890229152 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpstorage0' changed state to 1(NULL) successfully
0:00:06.890239629 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpsession0> current READY pending VOID_PENDING, desired next NULL
0:00:06.890250105 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession0> completed state change to NULL
0:00:06.890259673 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:06.890275318 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpsession0' changed state to 1(NULL) successfully
0:00:06.890286283 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<manager> completed state change to NULL
0:00:06.890296480 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:06.890315757 230119 0x557ab60530c0 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<rtspsrc0> removed child "manager"
0:00:06.890337338 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux0> completed state change to NULL
0:00:06.890345789 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession0> completed state change to NULL
0:00:06.890356754 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage0> completed state change to NULL
0:00:06.890369675 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpsession0> removing pad 'recv_rtp_sink'
0:00:06.890381059 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking recv_rtp_sink_0:proxypad0(0x7f150c01a100) and rtpsession0:recv_rtp_sink(0x7f150c014420)
0:00:06.890392095 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked recv_rtp_sink_0:proxypad0 and rtpsession0:recv_rtp_sink
0:00:06.890403060 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpsession0> removing pad 'recv_rtp_src'
0:00:06.890414933 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpsession0:recv_rtp_src(0x7f150c014670) and rtpstorage0:sink(0x7f150c0141d0)
0:00:06.890428413 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpsession0:recv_rtp_src and rtpstorage0:sink
0:00:06.890447829 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<manager> removing pad 'recv_rtp_sink_0'
0:00:06.890458934 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<manager> removing pad 'recv_rtcp_sink_0'
0:00:06.890469759 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking recv_rtcp_sink_0:proxypad1(0x7f150c01a360) and rtpsession0:recv_rtcp_sink(0x7f150c0148c0)
0:00:06.890480725 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked recv_rtcp_sink_0:proxypad1 and rtpsession0:recv_rtcp_sink
0:00:06.890493715 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpsession0> removing pad 'recv_rtcp_sink'
0:00:06.890503563 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpsession0> removing pad 'sync_src'
0:00:06.890515087 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpsession0:sync_src(0x7f150c014b10) and rtpssrcdemux0:rtcp_sink(0x557ab5fef3c0)
0:00:06.890528008 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpsession0:sync_src and rtpssrcdemux0:rtcp_sink
0:00:06.890544142 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<manager> removing pad 'send_rtcp_src_0'
0:00:06.890553850 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpsession0:send_rtcp_src(0x7f150c015450) and send_rtcp_src_0:proxypad2(0x7f150c01a5c0)
0:00:06.890566002 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpsession0:send_rtcp_src and send_rtcp_src_0:proxypad2
0:00:06.890581717 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpsession0> removing pad 'send_rtcp_src'
0:00:06.890594079 230119 0x557ab60530c0 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<manager> removed child "rtpsession0"
0:00:06.890606720 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtpsession0> 0x7f150c0d80b0 dispose
0:00:06.890615870 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtpsession0> 0x7f150c0d80b0 parent class dispose
0:00:06.890640594 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtpsession0> 0x7f150c0d80b0 finalize
0:00:06.890647299 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtpsession0> 0x7f150c0d80b0 finalize parent
0:00:06.890661128 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpstorage0:src(0x557ab5fefd00) and rtpssrcdemux0:sink(0x557ab5fefab0)
0:00:06.890673001 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpstorage0:src and rtpssrcdemux0:sink
0:00:06.890685084 230119 0x557ab60530c0 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<manager> removed child "rtpssrcdemux0"
0:00:06.890697865 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtpssrcdemux0> 0x557ab5fca9d0 dispose
0:00:06.890705897 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpssrcdemux0> removing pad 'sink'
0:00:06.890719795 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpssrcdemux0> removing pad 'rtcp_sink'
0:00:06.890730761 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtpssrcdemux0> 0x557ab5fca9d0 parent class dispose
0:00:06.890740818 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtpssrcdemux0> 0x557ab5fca9d0 finalize
0:00:06.890751294 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtpssrcdemux0> 0x557ab5fca9d0 finalize parent
0:00:06.890763167 230119 0x557ab60530c0 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<manager> removed child "rtpstorage0"
0:00:06.890778044 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtpstorage0> 0x557ab5ff05a0 dispose
0:00:06.890786076 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpstorage0> removing pad 'src'
0:00:06.890798927 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpstorage0> removing pad 'sink'
0:00:06.890810032 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtpstorage0> 0x557ab5ff05a0 parent class dispose
0:00:06.890818483 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtpstorage0> 0x557ab5ff05a0 finalize
0:00:06.890828400 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtpstorage0> 0x557ab5ff05a0 finalize parent
0:00:06.890842229 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<manager> 0x7f150c0d4050 dispose
0:00:06.890850261 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<manager> 0x7f150c0d4050 parent class dispose
0:00:06.890864369 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<manager> 0x7f150c0d4050 finalize
0:00:06.890871563 230119 0x557ab60530c0 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<manager> 0x7f150c0d4050 finalize parent
0:00:06.890891538 230119 0x557ab60530c0 WARN                 rtspsrc gstrtspsrc.c:5769:gst_rtspsrc_reconnect:<rtspsrc0> warning: Could not receive any UDP packets for 5.0000 seconds, maybe your firewall is blocking it. Retrying using a tcp connection.
0:00:06.890908859 230119 0x557ab60530c0 INFO        GST_ERROR_SYSTEM gstelement.c:2153:gst_element_message_full_with_details:<rtspsrc0> posting message: Could not read from resource.
0:00:06.890928275 230119 0x557ab60530c0 INFO        GST_ERROR_SYSTEM gstelement.c:2180:gst_element_message_full_with_details:<rtspsrc0> posted warning message: Could not read from resource.
WARNING: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Could not read from resource.
Additional debug info:
gstrtspsrc.c(5769): gst_rtspsrc_reconnect (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
Could not receive any UDP packets for 5.0000 seconds, maybe your firewall is blocking it. Retrying using a tcp connection.
0:00:06.907069213 230119 0x557ab60530c0 INFO                 rtspsrc gstrtspsrc.c:7788:gst_rtspsrc_retrieve_sdp:<rtspsrc0> Now using version: 1.0
0:00:06.914787781 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:360:gst_element_factory_create: creating element "rtpbin" named "manager"
0:00:06.914833528 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<manager> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:06.914844144 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed NULL to READY (PAUSED pending)
0:00:06.914864398 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<manager> continue state change READY to PAUSED, final PAUSED
0:00:06.914873478 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<manager> completed state change to PAUSED
0:00:06.914881509 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:06.914926139 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'recv_rtp_sink_0' in element "manager"
0:00:06.914936685 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtpsession"
0:00:06.914984387 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtpssrcdemux"
0:00:06.915003035 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpSsrcDemux@0x557ab5fca8a0> adding pad 'sink'
0:00:06.915019658 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpSsrcDemux@0x557ab5fca8a0> adding pad 'rtcp_sink'
0:00:06.915033556 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtpstorage"
0:00:06.915065544 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpStorage@0x7f14f0006000> adding pad 'src'
0:00:06.915073995 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpStorage@0x7f14f0006000> adding pad 'sink'
0:00:06.915129241 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<rtpssrcdemux1> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:06.915139996 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux1> notifying about state-changed NULL to READY (PAUSED pending)
0:00:06.915158016 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<rtpssrcdemux1> continue state change READY to PAUSED, final PAUSED
0:00:06.915167165 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux1> completed state change to PAUSED
0:00:06.915174289 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:06.915187070 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<rtpsession1> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:06.915194334 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession1> notifying about state-changed NULL to READY (PAUSED pending)
0:00:06.915206277 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<rtpsession1> continue state change READY to PAUSED, final PAUSED
0:00:06.915213331 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession1> completed state change to PAUSED
0:00:06.915220525 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:06.915231560 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<rtpstorage1> committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:06.915238195 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage1> notifying about state-changed NULL to READY (PAUSED pending)
0:00:06.915249090 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<rtpstorage1> continue state change READY to PAUSED, final PAUSED
0:00:06.915257820 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage1> completed state change to PAUSED
0:00:06.915263967 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage1> notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:06.915279611 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'recv_rtp_sink' in element "rtpsession1"
0:00:06.915297770 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpsession1> adding pad 'recv_rtp_sink'
0:00:06.915312018 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpsession1> adding pad 'recv_rtp_src'
0:00:06.915336812 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link recv_rtp_sink_0:proxypad3 and rtpsession1:recv_rtp_sink
0:00:06.915346381 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked recv_rtp_sink_0:proxypad3 and rtpsession1:recv_rtp_sink, successful
0:00:06.915352247 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.915364959 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<manager> adding pad 'recv_rtp_sink_0'
0:00:06.915380115 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpsession1:recv_rtp_src
0:00:06.915392966 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpstorage1:sink
0:00:06.915412312 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpsession1:recv_rtp_src and rtpstorage1:sink
0:00:06.915427677 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:4237:gst_pad_peer_query:<rtpstorage1:src> pad has no peer
0:00:06.915441366 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpsession1:recv_rtp_src and rtpstorage1:sink, successful
0:00:06.915447652 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.915463856 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpstorage1:src
0:00:06.915472376 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpssrcdemux1:sink
0:00:06.915484878 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpstorage1:src and rtpssrcdemux1:sink
0:00:06.915494866 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpstorage1:src and rtpssrcdemux1:sink, successful
0:00:06.915502409 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.915522034 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'recv_rtcp_sink_0' in element "manager"
0:00:06.915533419 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'recv_rtcp_sink' in element "rtpsession1"
0:00:06.915555838 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpsession1> adding pad 'recv_rtcp_sink'
0:00:06.915573578 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpsession1> adding pad 'sync_src'
0:00:06.915587337 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpsession1:sync_src
0:00:06.915596836 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpssrcdemux1:rtcp_sink
0:00:06.915611293 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpsession1:sync_src and rtpssrcdemux1:rtcp_sink
0:00:06.915621141 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpsession1:sync_src and rtpssrcdemux1:rtcp_sink, successful
0:00:06.915629731 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.915654526 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link recv_rtcp_sink_0:proxypad4 and rtpsession1:recv_rtcp_sink
0:00:06.915662069 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked recv_rtcp_sink_0:proxypad4 and rtpsession1:recv_rtcp_sink, successful
0:00:06.915667796 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.915679320 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<manager> adding pad 'recv_rtcp_sink_0'
0:00:06.915696361 230119 0x557ab60530c0 INFO                 rtspsrc gstrtspsrc.c:3953:gst_rtspsrc_stream_configure_manager:<rtspsrc0> configure bandwidth in session 0x7f150c0e03d0
0:00:06.915707466 230119 0x557ab60530c0 INFO                 rtspsrc gstrtspsrc.c:3958:gst_rtspsrc_stream_configure_manager:<rtspsrc0> setting AS: 5000000.000000
0:00:06.915739454 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link '':internalsrc_0 and manager:recv_rtp_sink_0
0:00:06.915748883 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked '':internalsrc_0 and manager:recv_rtp_sink_0, successful
0:00:06.915757403 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.915767531 230119 0x557ab60530c0 INFO               GST_EVENT gstpad.c:5812:gst_pad_send_event_unchecked:<'':internalsrc_0> Received event on flushing pad. Discarding
0:00:06.915783734 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link '':internalsrc_1 and manager:recv_rtcp_sink_0
0:00:06.915792744 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked '':internalsrc_1 and manager:recv_rtcp_sink_0, successful
0:00:06.915800985 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.915810414 230119 0x557ab60530c0 INFO               GST_EVENT gstpad.c:5812:gst_pad_send_event_unchecked:<'':internalsrc_1> Received event on flushing pad. Discarding
0:00:06.915829481 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'send_rtcp_src_0' in element "manager"
0:00:06.915839538 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'send_rtcp_src' in element "rtpsession1"
0:00:06.915854694 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpsession1> adding pad 'send_rtcp_src'
0:00:06.915882771 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpsession1:send_rtcp_src and send_rtcp_src_0:proxypad5
0:00:06.915892479 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpsession1:send_rtcp_src and send_rtcp_src_0:proxypad5, successful
0:00:06.915900650 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.915916155 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<manager> adding pad 'send_rtcp_src_0'
0:00:06.915931870 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link manager:send_rtcp_src_0 and '':internalsink_0
0:00:06.915940321 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked manager:send_rtcp_src_0 and '':internalsink_0, successful
0:00:06.915948772 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.918004514 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpssrcdemux1> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:06.918015480 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux1> completed state change to PLAYING
0:00:06.918022045 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux1> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:06.918035315 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpssrcdemux1' changed state to 4(PLAYING) successfully
0:00:06.918043417 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpstorage1> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:06.918049563 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage1> completed state change to PLAYING
0:00:06.918058433 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage1> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:06.918076173 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpstorage1' changed state to 4(PLAYING) successfully
0:00:06.918087068 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpsession1> current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:06.918131907 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession1> completed state change to PLAYING
0:00:06.918141056 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession1> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:06.918159006 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpsession1' changed state to 4(PLAYING) successfully
0:00:06.918166269 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<manager> completed state change to PLAYING
0:00:06.918172485 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:06.991816523 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:820:gst_event_new_caps: creating caps event application/x-rtp, media=(string)video, payload=(int)96, clock-rate=(int)90000, encoding-name=(string)H265, profile-level-id=(string)420029, packetization-mode=(string)1, sprop-parameter-sets=(string)"QgEBAWAAAAMAAAMAAAMAAAMAeKADwIARB8uNrkk5TNxEMyIRAAAAAHAAAAAA\,RAHA8vAiQA\=\=", a-Media_header=(string)"MEDIAINFO\=494D4B48010100000400050000000000000000000000000000000000000000000000000000000000\;", a-appversion=(string)1.0, ssrc=(uint)2082926118, clock-base=(uint)1867957952, seqnum-base=(uint)29823, npt-start=(guint64)0, play-speed=(double)1, play-scale=(double)1
0:00:06.991887553 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:820:gst_event_new_caps: creating caps event application/x-rtcp
0:00:06.991922823 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:900:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:06.992054057 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:820:gst_event_new_caps: creating caps event application/x-rtp, media=(string)video, payload=(int)96, clock-rate=(int)90000, encoding-name=(string)H265, profile-level-id=(string)420029, packetization-mode=(string)1, sprop-parameter-sets=(string)"QgEBAWAAAAMAAAMAAAMAAAMAeKADwIARB8uNrkk5TNxEMyIRAAAAAHAAAAAA\,RAHA8vAiQA\=\=", a-Media_header=(string)"MEDIAINFO\=494D4B48010100000400050000000000000000000000000000000000000000000000000000000000\;", a-appversion=(string)1.0, ssrc=(uint)2082926118, clock-base=(uint)1867957952, seqnum-base=(uint)29823, npt-start=(guint64)0, play-speed=(double)1, play-scale=(double)1
0:00:06.992071797 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:820:gst_event_new_caps: creating caps event application/x-rtcp, ssrc=(uint)2082926118
0:00:06.992081715 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpssrcdemux1> adding pad 'src_2082926118'
0:00:06.992090445 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpssrcdemux1> adding pad 'rtcp_src_2082926118'
0:00:06.992100363 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtpjitterbuffer"
0:00:06.992213228 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpJitterBuffer@0x7f150c02db50> adding pad 'src'
0:00:06.992221819 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpJitterBuffer@0x7f150c02db50> adding pad 'sink'
0:00:06.992231178 230119 0x557ab60530c0 INFO     GST_ELEMENT_FACTORY gstelementfactory.c:363:gst_element_factory_create: creating element "rtpptdemux"
0:00:06.992284118 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<GstRtpPtDemux@0x7f150c033040> adding pad 'sink'
0:00:06.992326513 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstutils.c:1771:gst_element_link_pads_full: trying to link element rtpjitterbuffer0:src to element rtpptdemux0:sink
0:00:06.992335034 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpjitterbuffer0:src
0:00:06.992343205 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpptdemux0:sink
0:00:06.992355148 230119 0x557ab60530c0 INFO                GST_PADS gstutils.c:1587:prepare_link_maybe_ghosting: rtpjitterbuffer0 and rtpptdemux0 in same bin, no need for ghost pads
0:00:06.992370374 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpjitterbuffer0:src and rtpptdemux0:sink
0:00:06.992381898 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpjitterbuffer0:src and rtpptdemux0:sink, successful
0:00:06.992391327 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.992400895 230119 0x557ab60530c0 INFO               GST_EVENT gstpad.c:5812:gst_pad_send_event_unchecked:<rtpjitterbuffer0:src> Received event on flushing pad. Discarding
0:00:06.992419054 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<rtpptdemux0> committing state from NULL to READY, pending PLAYING, next PAUSED
0:00:06.992428483 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpptdemux0> notifying about state-changed NULL to READY (PLAYING pending)
0:00:06.992449156 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<rtpptdemux0> continue state change READY to PAUSED, final PLAYING
0:00:06.992462286 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<rtpptdemux0> committing state from READY to PAUSED, pending PLAYING, next PLAYING
0:00:06.992472763 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpptdemux0> notifying about state-changed READY to PAUSED (PLAYING pending)
0:00:06.992495881 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<rtpptdemux0> continue state change PAUSED to PLAYING, final PLAYING
0:00:06.992503074 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpptdemux0> completed state change to PLAYING
0:00:06.992512713 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpptdemux0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:06.992530662 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<rtpjitterbuffer0> committing state from NULL to READY, pending PLAYING, next PAUSED
0:00:06.992539393 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpjitterbuffer0> notifying about state-changed NULL to READY (PLAYING pending)
0:00:06.992555037 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<rtpjitterbuffer0> continue state change READY to PAUSED, final PLAYING
0:00:06.992613705 230119 0x557ab60530c0 INFO                    task gsttask.c:460:gst_task_set_lock: setting stream lock 0x7f150c014dd0 on task 0x7f14f0006170
0:00:06.992623692 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:6159:gst_pad_start_task:<rtpjitterbuffer0:src> created task 0x7f14f0006170
0:00:06.992648486 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<rtpjitterbuffer0> committing state from READY to PAUSED, pending PLAYING, next PLAYING
0:00:06.992660429 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpjitterbuffer0> notifying about state-changed READY to PAUSED (PLAYING pending)
0:00:06.992677541 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<rtpjitterbuffer0> continue state change PAUSED to PLAYING, final PLAYING
0:00:06.992687109 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpjitterbuffer0> completed state change to PLAYING
0:00:06.992697725 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpjitterbuffer0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:06.992711414 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpssrcdemux1:src_2082926118
0:00:06.992720983 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpjitterbuffer0:sink
0:00:06.992734462 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpssrcdemux1:src_2082926118 and rtpjitterbuffer0:sink
0:00:06.992745218 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpssrcdemux1:src_2082926118 and rtpjitterbuffer0:sink, successful
0:00:06.992753739 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:06.992772946 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:928:gst_element_get_static_pad: found pad rtpssrcdemux1:rtcp_src_2082926118
0:00:06.992782863 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'sink_rtcp' in element "rtpjitterbuffer0"
0:00:06.992806819 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpjitterbuffer0> adding pad 'sink_rtcp'
0:00:06.992819042 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpssrcdemux1:rtcp_src_2082926118 and rtpjitterbuffer0:sink_rtcp
0:00:06.992831055 230119 0x557ab60530c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpssrcdemux1:rtcp_src_2082926118 and rtpjitterbuffer0:sink_rtcp, successful
0:00:06.992836782 230119 0x557ab60530c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:08.026485125 230119 0x7f150c0c1000 INFO               GST_EVENT gstevent.c:820:gst_event_new_caps: creating caps event application/x-rtcp
0:00:08.026531361 230119 0x7f150c0c1000 INFO               GST_EVENT gstevent.c:900:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
0:00:39.542063416 230119 0x557ab60530c0 INFO         rtpjitterbuffer rtpjitterbuffer.c:795:rtp_jitter_buffer_calculate_pts: resync to time 0:00:37.663948399, rtptime 11:43:01.463088888
0:00:39.542189482 230119 0x7f150c0c18c0 INFO               GST_EVENT gstevent.c:820:gst_event_new_caps: creating caps event application/x-rtp, media=(string)video, payload=(int)96, clock-rate=(int)90000, encoding-name=(string)H265, profile-level-id=(string)420029, packetization-mode=(string)1, sprop-parameter-sets=(string)"QgEBAWAAAAMAAAMAAAMAAAMAeKADwIARB8uNrkk5TNxEMyIRAAAAAHAAAAAA\,RAHA8vAiQA\=\=", a-Media_header=(string)"MEDIAINFO\=494D4B48010100000400050000000000000000000000000000000000000000000000000000000000\;", a-appversion=(string)1.0, ssrc=(uint)2082926118, clock-base=(uint)1867957952, seqnum-base=(uint)29823, npt-start=(guint64)0, play-speed=(double)1, play-scale=(double)1
0:00:39.542213857 230119 0x7f150c0c18c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtpptdemux0> adding pad 'src_96'
0:00:39.542266658 230119 0x7f150c0c18c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link rtpptdemux0:src_96 and recv_rtp_src_0_2082926118_96:proxypad6
0:00:39.542279160 230119 0x7f150c0c18c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked rtpptdemux0:src_96 and recv_rtp_src_0_2082926118_96:proxypad6, successful
0:00:39.542288099 230119 0x7f150c0c18c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:39.542318132 230119 0x7f150c0c18c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<manager> adding pad 'recv_rtp_src_0_2082926118_96'
0:00:39.542361574 230119 0x7f150c0c18c0 INFO                GST_PADS gstpad.c:2377:gst_pad_link_prepare: trying to link manager:recv_rtp_src_0_2082926118_96 and recv_rtp_src_0_2082926118_96:proxypad7
0:00:39.542390069 230119 0x7f150c0c18c0 INFO                GST_PADS gstpad.c:2585:gst_pad_link_full: linked manager:recv_rtp_src_0_2082926118_96 and recv_rtp_src_0_2082926118_96:proxypad7, successful
0:00:39.542400057 230119 0x7f150c0c18c0 INFO               GST_EVENT gstevent.c:1579:gst_event_new_reconfigure: creating reconfigure event
0:00:39.542422965 230119 0x7f150c0c18c0 INFO        GST_ELEMENT_PADS gstelement.c:671:gst_element_add_pad:<rtspsrc0> adding pad 'recv_rtp_src_0_2082926118_96'
0:00:39.542442102 230119 0x7f150c0c18c0 INFO            GST_PIPELINE grammar.y:520:gst_parse_found_pad: trying delayed linking one pad some pad of GstRTSPSrc named rtspsrc0 to some pad of GstRtpH264Depay named rtph264depay0
0:00:39.542452509 230119 0x7f150c0c18c0 INFO        GST_ELEMENT_PADS gstutils.c:1771:gst_element_link_pads_full: trying to link element rtspsrc0:(any) to element rtph264depay0:(any)
0:00:39.542465918 230119 0x7f150c0c18c0 INFO                GST_PADS gstutils.c:1034:gst_pad_check_link: trying to link rtspsrc0:recv_rtp_src_0_2082926118_96 and rtph264depay0:sink
0:00:39.542508383 230119 0x7f150c0c18c0 INFO        GST_ELEMENT_PADS gstutils.c:1225:gst_element_get_compatible_pad:<rtph264depay0> Could not find a compatible pad to link to rtspsrc0:recv_rtp_src_0_2082926118_96
0:00:39.542518789 230119 0x7f150c0c18c0 INFO                GST_PADS gstutils.c:1034:gst_pad_check_link: trying to link rtspsrc0:recv_rtp_src_0_2082926118_96 and rtph264depay0:sink
0:00:39.542544072 230119 0x7f150c0c18c0 INFO        GST_ELEMENT_PADS gstelement.c:925:gst_element_get_static_pad: no such pad 'stream_%u' in element "rtspsrc0"
0:00:39.542554129 230119 0x7f150c0c18c0 INFO        GST_ELEMENT_PADS gstutils.c:1225:gst_element_get_compatible_pad:<rtspsrc0> Could not find a compatible pad to link to rtph264depay0:sink
0:00:39.542568028 230119 0x7f150c0c18c0 INFO                 default gstutils.c:2161:gst_element_link_pads_filtered: Could not link pads: rtspsrc0:(null) - rtph264depay0:(null)
0:00:39.542588911 230119 0x7f150c0c18c0 WARN                 default grammar.y:506:gst_parse_no_more_pads:<rtspsrc0> warning: Delayed linking failed.
0:00:39.542596663 230119 0x7f150c0c18c0 WARN                 default grammar.y:506:gst_parse_no_more_pads:<rtspsrc0> warning: failed delayed linking some pad of GstRTSPSrc named rtspsrc0 to some pad of GstRtpH264Depay named rtph264depay0
0:00:39.542614613 230119 0x7f150c0c18c0 INFO        GST_ERROR_SYSTEM gstelement.c:2153:gst_element_message_full_with_details:<rtspsrc0> posting message: Delayed linking failed.
0:00:39.542634797 230119 0x7f150c0c18c0 INFO        GST_ERROR_SYSTEM gstelement.c:2180:gst_element_message_full_with_details:<rtspsrc0> posted warning message: Delayed linking failed.
0:00:39.542657496 230119 0x7f150c0c18c0 INFO                GST_PADS gstpad.c:4237:gst_pad_peer_query:<rtspsrc0:recv_rtp_src_0_2082926118_96> pad has no peer
0:00:39.542673001 230119 0x7f150c0c18c0 INFO                GST_PADS gstpad.c:4237:gst_pad_peer_query:<rtspsrc0:recv_rtp_src_0_2082926118_96> pad has no peer
WARNING: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Delayed linking failed.
Additional debug info:
./grammar.y(506): gst_parse_no_more_pads (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
failed delayed linking some pad of GstRTSPSrc named rtspsrc0 to some pad of GstRtpH264Depay named rtph264depay0
0:00:39.542737396 230119 0x7f150c0c18c0 INFO                    task gsttask.c:312:gst_task_func:<rtpjitterbuffer0:src> Task going to paused
0:00:39.591827572 230119 0x557ab60530c0 WARN                 rtspsrc gstrtspsrc.c:6057:gst_rtspsrc_loop:<rtspsrc0> error: Internal data stream error.
0:00:39.591840912 230119 0x557ab60530c0 WARN                 rtspsrc gstrtspsrc.c:6057:gst_rtspsrc_loop:<rtspsrc0> error: streaming stopped, reason not-linked (-1)
0:00:39.591855649 230119 0x557ab60530c0 INFO        GST_ERROR_SYSTEM gstelement.c:2153:gst_element_message_full_with_details:<rtspsrc0> posting message: Internal data stream error.
0:00:39.591872830 230119 0x557ab60530c0 INFO        GST_ERROR_SYSTEM gstelement.c:2180:gst_element_message_full_with_details:<rtspsrc0> posted error message: Internal data stream error.
0:00:39.591924863 230119 0x557ab60530c0 INFO                    task gsttask.c:312:gst_task_func:<task0> Task going to paused
ERROR: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Internal data stream error.
Additional debug info:
gstrtspsrc.c(6057): gst_rtspsrc_loop (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
streaming stopped, reason not-linked (-1)
Execution ended after 0:00:37.713595849
Setting pipeline to NULL ...
0:00:39.591987232 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<kvssink0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:39.592013074 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<kvssink0> completed state change to PAUSED
0:00:39.592022014 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<kvssink0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:39.592037728 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'kvssink0' changed state to 3(PAUSED) successfully
0:00:39.592046458 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<h264parse0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:39.592053932 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<h264parse0> completed state change to PAUSED
0:00:39.592060986 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:39.592071183 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 3(PAUSED) successfully
0:00:39.592079284 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtph264depay0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:39.592087316 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtph264depay0> completed state change to PAUSED
0:00:39.592093951 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtph264depay0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:39.592102682 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'rtph264depay0' changed state to 3(PAUSED) successfully
0:00:39.592110225 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtspsrc0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:39.592122098 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<rtspsrc0> child 'manager' changed state to 3(PAUSED) successfully
0:00:39.592125450 230119 0x557ab60530c0 INFO                    task gsttask.c:314:gst_task_func:<task0> Task resume from paused
0:00:39.592136066 230119 0x557ab60530c0 INFO                    task gsttask.c:312:gst_task_func:<task0> Task going to paused
0:00:39.592147451 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtspsrc0> completed state change to PAUSED
0:00:39.592152619 230119 0x557ab60530c0 INFO                    task gsttask.c:314:gst_task_func:<task0> Task resume from paused
0:00:39.592154505 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtspsrc0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:39.592164632 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2995:gst_bin_change_state_func:<pipeline0> child 'rtspsrc0' changed state to 3(PAUSED) successfully without preroll
0:00:39.592174550 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<pipeline0> committing state from PLAYING to PAUSED, pending NULL, next READY
0:00:39.592181254 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed PLAYING to PAUSED (NULL pending)
0:00:39.592199972 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<pipeline0> continue state change PAUSED to READY, final NULL
0:00:39.592211706 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<kvssink0> current PAUSED pending VOID_PENDING, desired next READY
0:00:39.592227630 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<kvssink0> completed state change to READY
0:00:39.592234265 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<kvssink0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:39.592243135 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'kvssink0' changed state to 2(READY) successfully
0:00:39.592249910 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<h264parse0> current PAUSED pending VOID_PENDING, desired next READY
0:00:39.592319123 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<h264parse0> completed state change to READY
0:00:39.592329739 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:39.592337841 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 2(READY) successfully
0:00:39.592345384 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtph264depay0> current PAUSED pending VOID_PENDING, desired next READY
0:00:39.592356419 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtph264depay0> completed state change to READY
0:00:39.592363124 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtph264depay0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:39.592370737 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'rtph264depay0' changed state to 2(READY) successfully
0:00:39.592387429 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<rtspsrc0> child 'manager' changed state to 2(READY) successfully
0:00:39.592417951 230119 0x557ab60530c0 WARN                 rtspsrc gstrtspsrc.c:6326:gst_rtsp_src_receive_response:<rtspsrc0> receive interrupted
0:00:39.592427030 230119 0x557ab60530c0 WARN                 rtspsrc gstrtspsrc.c:6424:gst_rtspsrc_try_send:<rtspsrc0> receive interrupted
0:00:39.592432687 230119 0x557ab60530c0 WARN                 rtspsrc gstrtspsrc.c:8672:gst_rtspsrc_pause:<rtspsrc0> PAUSE interrupted
0:00:39.592470821 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpptdemux0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:39.592479901 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpptdemux0> completed state change to PAUSED
0:00:39.592487164 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpptdemux0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:39.592497501 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpptdemux0' changed state to 3(PAUSED) successfully
0:00:39.592505603 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpjitterbuffer0> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:39.592512378 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpjitterbuffer0> completed state change to PAUSED
0:00:39.592519152 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpjitterbuffer0> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:39.592528511 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2995:gst_bin_change_state_func:<manager> child 'rtpjitterbuffer0' changed state to 3(PAUSED) successfully without preroll
0:00:39.592536962 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpssrcdemux1> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:39.592544086 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux1> completed state change to PAUSED
0:00:39.592551280 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux1> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:39.592560220 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpssrcdemux1' changed state to 3(PAUSED) successfully
0:00:39.592568182 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpstorage1> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:39.592574398 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage1> completed state change to PAUSED
0:00:39.592581591 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage1> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:39.592590182 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpstorage1' changed state to 3(PAUSED) successfully
0:00:39.592597795 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpsession1> current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:39.592609249 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession1> completed state change to PAUSED
0:00:39.592616024 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession1> notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:39.592625033 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpsession1' changed state to 3(PAUSED) successfully
0:00:39.592633973 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<manager> committing state from PLAYING to PAUSED, pending READY, next READY
0:00:39.592640259 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed PLAYING to PAUSED (READY pending)
0:00:39.592649339 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<manager> continue state change PAUSED to READY, final READY
0:00:39.592669314 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpptdemux0> current PAUSED pending VOID_PENDING, desired next READY
0:00:39.592682723 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpptdemux0> completed state change to READY
0:00:39.592690336 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpptdemux0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:39.592700743 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpptdemux0' changed state to 2(READY) successfully
0:00:39.592753194 230119 0x7f150c0c18c0 INFO                    task gsttask.c:314:gst_task_func:<rtpjitterbuffer0:src> Task resume from paused
0:00:39.592823945 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpjitterbuffer0> completed state change to READY
0:00:39.592831558 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpjitterbuffer0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:39.592841196 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpjitterbuffer0' changed state to 2(READY) successfully
0:00:39.592849787 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpssrcdemux1> current PAUSED pending VOID_PENDING, desired next READY
0:00:39.592865431 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpssrcdemux1> removing pad 'src_2082926118'
0:00:39.592875489 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpssrcdemux1:src_2082926118(0x7f150c014fb0) and rtpjitterbuffer0:sink(0x557ab5fef610)
0:00:39.592885476 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpssrcdemux1:src_2082926118 and rtpjitterbuffer0:sink
0:00:39.592896441 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpssrcdemux1> removing pad 'rtcp_src_2082926118'
0:00:39.592904124 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpssrcdemux1:rtcp_src_2082926118(0x557ab5fef860) and rtpjitterbuffer0:sink_rtcp(0x7f150c015d90)
0:00:39.592914600 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpssrcdemux1:rtcp_src_2082926118 and rtpjitterbuffer0:sink_rtcp
0:00:39.592925007 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux1> completed state change to READY
0:00:39.592931782 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux1> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:39.592940791 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpssrcdemux1' changed state to 2(READY) successfully
0:00:39.592951268 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpptdemux0> current READY pending VOID_PENDING, desired next READY
0:00:39.592958392 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2621:gst_bin_element_set_state:<rtpptdemux0> skipping transition from READY to  READY
0:00:39.592965655 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpptdemux0' changed state to 2(READY) successfully
0:00:39.592971801 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpjitterbuffer0> current READY pending VOID_PENDING, desired next READY
0:00:39.592977947 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2621:gst_bin_element_set_state:<rtpjitterbuffer0> skipping transition from READY to  READY
0:00:39.592984652 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpjitterbuffer0' changed state to 2(READY) successfully
0:00:39.592992335 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpssrcdemux1> current READY pending VOID_PENDING, desired next READY
0:00:39.592998132 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2621:gst_bin_element_set_state:<rtpssrcdemux1> skipping transition from READY to  READY
0:00:39.593004208 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpssrcdemux1' changed state to 2(READY) successfully
0:00:39.593011821 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpstorage1> current PAUSED pending VOID_PENDING, desired next READY
0:00:39.593022367 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage1> completed state change to READY
0:00:39.593029142 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage1> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:39.593038082 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpstorage1' changed state to 2(READY) successfully
0:00:39.593045625 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpsession1> current PAUSED pending VOID_PENDING, desired next READY
0:00:39.593087949 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession1> completed state change to READY
0:00:39.593095213 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession1> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:39.593105689 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpsession1' changed state to 2(READY) successfully
0:00:39.593120426 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<manager> completed state change to READY
0:00:39.593127201 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:39.641984941 230119 0x557ab60530c0 WARN                 rtspsrc gstrtspsrc.c:6585:gst_rtspsrc_send:<rtspsrc0> error: Unhandled error
0:00:39.641993113 230119 0x557ab60530c0 WARN                 rtspsrc gstrtspsrc.c:6585:gst_rtspsrc_send:<rtspsrc0> error: Option not supported (551)
0:00:39.642003589 230119 0x557ab60530c0 INFO        GST_ERROR_SYSTEM gstelement.c:2153:gst_element_message_full_with_details:<rtspsrc0> posting message: Unhandled error
0:00:39.642013018 230119 0x557ab60530c0 INFO        GST_ERROR_SYSTEM gstelement.c:2180:gst_element_message_full_with_details:<rtspsrc0> posted error message: Unhandled error
0:00:39.642019304 230119 0x557ab60530c0 WARN                 rtspsrc gstrtspsrc.c:8096:gst_rtspsrc_close:<rtspsrc0> error: Could not send message. (Generic error)
0:00:39.642026009 230119 0x557ab60530c0 INFO        GST_ERROR_SYSTEM gstelement.c:2153:gst_element_message_full_with_details:<rtspsrc0> posting message: Could not write to resource.
0:00:39.642031177 230119 0x557ab60530c0 INFO        GST_ERROR_SYSTEM gstelement.c:2180:gst_element_message_full_with_details:<rtspsrc0> posted error message: Could not write to resource.
0:00:39.642066517 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking '':internalsrc_0(0x7f150c014670) and manager:recv_rtp_sink_0(0x7f150c018930)
0:00:39.642072174 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked '':internalsrc_0 and manager:recv_rtp_sink_0
0:00:39.642079368 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking '':internalsrc_1(0x7f150c015200) and manager:recv_rtcp_sink_0(0x7f150c0186b0)
0:00:39.642084676 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked '':internalsrc_1 and manager:recv_rtcp_sink_0
0:00:39.642091800 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtspsrc0> removing pad 'recv_rtp_src_0_2082926118_96'
0:00:39.642097457 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking manager:recv_rtp_src_0_2082926118_96(0x7f150c018bb0) and recv_rtp_src_0_2082926118_96:proxypad7(0x7f150c01ace0)
0:00:39.642104162 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked manager:recv_rtp_src_0_2082926118_96 and recv_rtp_src_0_2082926118_96:proxypad7
0:00:39.642112264 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking manager:send_rtcp_src_0(0x7f150c018430) and '':internalsink_0(0x7f150c0156a0)
0:00:39.642117642 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked manager:send_rtcp_src_0 and '':internalsink_0
0:00:39.642131750 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpptdemux0> current READY pending VOID_PENDING, desired next NULL
0:00:39.642137547 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpptdemux0> removing pad 'src_96'
0:00:39.642142785 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpptdemux0:src_96(0x7f150c036610) and recv_rtp_src_0_2082926118_96:proxypad6(0x7f150c01aa80)
0:00:39.642147674 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpptdemux0:src_96 and recv_rtp_src_0_2082926118_96:proxypad6
0:00:39.642154798 230119 0x557ab60530c0 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<manager> removing pad 'recv_rtp_src_0_2082926118_96'
0:00:39.642161363 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpptdemux0> completed state change to NULL
0:00:39.642167021 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpptdemux0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:39.642173656 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpptdemux0' changed state to 1(NULL) successfully
0:00:39.642179872 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpptdemux0> current NULL pending VOID_PENDING, desired next NULL
0:00:39.642184132 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2621:gst_bin_element_set_state:<rtpptdemux0> skipping transition from NULL to  NULL
0:00:39.642188881 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpptdemux0' changed state to 1(NULL) successfully
0:00:39.642193491 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpjitterbuffer0> current READY pending VOID_PENDING, desired next NULL
0:00:39.642198240 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpjitterbuffer0> completed state change to NULL
0:00:39.642201523 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpjitterbuffer0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:39.642207739 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpjitterbuffer0' changed state to 1(NULL) successfully
0:00:39.642213047 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpssrcdemux1> current READY pending VOID_PENDING, desired next NULL
0:00:39.642217377 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux1> completed state change to NULL
0:00:39.642222126 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpssrcdemux1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:39.642227364 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpssrcdemux1' changed state to 1(NULL) successfully
0:00:39.642232533 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpstorage1> current READY pending VOID_PENDING, desired next NULL
0:00:39.642237282 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage1> completed state change to NULL
0:00:39.642241123 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpstorage1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:39.642246012 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpstorage1' changed state to 1(NULL) successfully
0:00:39.642250762 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtpsession1> current READY pending VOID_PENDING, desired next NULL
0:00:39.642256000 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession1> completed state change to NULL
0:00:39.642260260 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtpsession1> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:39.642265848 230119 0x557ab60530c0 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<manager> child 'rtpsession1' changed state to 1(NULL) successfully
0:00:39.642272133 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<manager> completed state change to NULL
0:00:39.642276464 230119 0x557ab60530c0 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<manager> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:39.642285054 230119 0x557ab60530c0 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<rtspsrc0> removed child "manager"
0:00:39.642304540 230119 0x557ab60530c0 INFO                    task gsttask.c:312:gst_task_func:<task0> Task going to paused
0:00:39.642326052 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtspsrc0> completed state change to READY
0:00:39.642337506 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtspsrc0> notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:39.642347563 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'rtspsrc0' changed state to 2(READY) successfully
0:00:39.642356503 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2660:gst_element_continue_state:<pipeline0> committing state from PAUSED to READY, pending NULL, next NULL
0:00:39.642361741 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed PAUSED to READY (NULL pending)
0:00:39.642372846 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2668:gst_element_continue_state:<pipeline0> continue state change READY to NULL, final NULL
0:00:39.642381856 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<kvssink0> current READY pending VOID_PENDING, desired next NULL
0:00:39.642390796 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<kvssink0> completed state change to NULL
0:00:39.642395126 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<kvssink0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:39.642400923 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'kvssink0' changed state to 1(NULL) successfully
0:00:39.642406231 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<h264parse0> current READY pending VOID_PENDING, desired next NULL
0:00:39.642410491 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<h264parse0> completed state change to NULL
0:00:39.642414263 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<h264parse0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:39.642419431 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'h264parse0' changed state to 1(NULL) successfully
0:00:39.642423692 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtph264depay0> current READY pending VOID_PENDING, desired next NULL
0:00:39.642428371 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtph264depay0> completed state change to NULL
0:00:39.642432701 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtph264depay0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:39.642438917 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'rtph264depay0' changed state to 1(NULL) successfully
0:00:39.642443178 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<rtspsrc0> current READY pending VOID_PENDING, desired next NULL
0:00:39.642456308 230119 0x557ab60530c0 INFO                    task gsttask.c:314:gst_task_func:<task0> Task resume from paused
0:00:39.642471184 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtspsrc0> completed state change to NULL
0:00:39.642476423 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<rtspsrc0> notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:39.642482150 230119 0x557ab5d78000 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'rtspsrc0' changed state to 1(NULL) successfully
0:00:39.642498283 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpssrcdemux1> completed state change to NULL
0:00:39.642502683 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpsession1> completed state change to NULL
0:00:39.642506944 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpstorage1> completed state change to NULL
0:00:39.642517839 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpsession1> removing pad 'recv_rtp_sink'
0:00:39.642523985 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking recv_rtp_sink_0:proxypad3(0x7f150c01a820) and rtpsession1:recv_rtp_sink(0x7f150c0141d0)
0:00:39.642530760 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked recv_rtp_sink_0:proxypad3 and rtpsession1:recv_rtp_sink
0:00:39.642535579 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpsession1> removing pad 'recv_rtp_src'
0:00:39.642540748 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpsession1:recv_rtp_src(0x557ab5fefd00) and rtpstorage1:sink(0x7f150c014420)
0:00:39.642546964 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpsession1:recv_rtp_src and rtpstorage1:sink
0:00:39.642555973 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<manager> removing pad 'recv_rtp_sink_0'
0:00:39.642562678 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<manager> removing pad 'recv_rtcp_sink_0'
0:00:39.642567497 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking recv_rtcp_sink_0:proxypad4(0x7f150c01a5c0) and rtpsession1:recv_rtcp_sink(0x557ab5fef3c0)
0:00:39.642572247 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked recv_rtcp_sink_0:proxypad4 and rtpsession1:recv_rtcp_sink
0:00:39.642577415 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpsession1> removing pad 'recv_rtcp_sink'
0:00:39.642581256 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpsession1> removing pad 'sync_src'
0:00:39.642586005 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpsession1:sync_src(0x557ab5fefab0) and rtpssrcdemux1:rtcp_sink(0x7f150c0148c0)
0:00:39.642590755 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpsession1:sync_src and rtpssrcdemux1:rtcp_sink
0:00:39.642596133 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<manager> removing pad 'send_rtcp_src_0'
0:00:39.642600393 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpsession1:send_rtcp_src(0x7f150c0158f0) and send_rtcp_src_0:proxypad5(0x7f150c01a360)
0:00:39.642605631 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpsession1:send_rtcp_src and send_rtcp_src_0:proxypad5
0:00:39.642612266 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpsession1> removing pad 'send_rtcp_src'
0:00:39.642618412 230119 0x557ab5d78000 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<manager> removed child "rtpsession1"
0:00:39.642627143 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpstorage1:src(0x7f150c014b10) and rtpssrcdemux1:sink(0x7f150c015450)
0:00:39.642632381 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpstorage1:src and rtpssrcdemux1:sink
0:00:39.642637549 230119 0x557ab5d78000 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<manager> removed child "rtpssrcdemux1"
0:00:39.642642718 230119 0x557ab5d78000 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<manager> removed child "rtpstorage1"
0:00:39.642648026 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpjitterbuffer0> completed state change to NULL
0:00:39.642652286 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<rtpptdemux0> completed state change to NULL
0:00:39.642659550 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtpjitterbuffer0:src(0x7f150c014d60) and rtpptdemux0:sink(0x7f150c015b40)
0:00:39.642664788 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtpjitterbuffer0:src and rtpptdemux0:sink
0:00:39.642669956 230119 0x557ab5d78000 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<manager> removed child "rtpjitterbuffer0"
0:00:39.642675613 230119 0x557ab5d78000 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<manager> removed child "rtpptdemux0"
0:00:39.642681829 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<manager> 0x7f150c0d42c0 dispose
0:00:39.642684763 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<manager> 0x7f150c0d42c0 parent class dispose
0:00:39.642691049 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<manager> 0x7f150c0d42c0 finalize
0:00:39.642693912 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<manager> 0x7f150c0d42c0 finalize parent
0:00:39.642698242 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtpsession1> 0x7f150c0d8360 dispose
0:00:39.642701036 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtpsession1> 0x7f150c0d8360 parent class dispose
0:00:39.642714166 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtpsession1> 0x7f150c0d8360 finalize
0:00:39.642717938 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtpsession1> 0x7f150c0d8360 finalize parent
0:00:39.642723735 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtpstorage1> 0x7f14f0006000 dispose
0:00:39.642728065 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpstorage1> removing pad 'src'
0:00:39.642732884 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpstorage1> removing pad 'sink'
0:00:39.642737633 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtpstorage1> 0x7f14f0006000 parent class dispose
0:00:39.642740916 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtpstorage1> 0x7f14f0006000 finalize
0:00:39.642745176 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtpstorage1> 0x7f14f0006000 finalize parent
0:00:39.642748459 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtpssrcdemux1> 0x557ab5fca8a0 dispose
0:00:39.642752789 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpssrcdemux1> removing pad 'sink'
0:00:39.642757608 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpssrcdemux1> removing pad 'rtcp_sink'
0:00:39.642763824 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtpssrcdemux1> 0x557ab5fca8a0 parent class dispose
0:00:39.642768644 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtpssrcdemux1> 0x557ab5fca8a0 finalize
0:00:39.642771926 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtpssrcdemux1> 0x557ab5fca8a0 finalize parent
0:00:39.642776606 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtpjitterbuffer0> 0x7f150c02db50 dispose
0:00:39.642781844 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpjitterbuffer0> removing pad 'sink_rtcp'
0:00:39.642787152 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpjitterbuffer0> removing pad 'src'
0:00:39.642791063 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpjitterbuffer0> removing pad 'sink'
0:00:39.642795323 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtpjitterbuffer0> 0x7f150c02db50 parent class dispose
0:00:39.642800981 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtpjitterbuffer0> 0x7f150c02db50 finalize
0:00:39.642805311 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtpjitterbuffer0> 0x7f150c02db50 finalize parent
0:00:39.642809501 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtpptdemux0> 0x7f150c033040 dispose
0:00:39.642812365 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtpptdemux0> removing pad 'sink'
0:00:39.642816695 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtpptdemux0> 0x7f150c033040 parent class dispose
0:00:39.642822073 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtpptdemux0> 0x7f150c033040 finalize
0:00:39.642826333 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtpptdemux0> 0x7f150c033040 finalize parent
0:00:39.642833876 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2688:gst_element_continue_state:<pipeline0> completed state change to NULL
0:00:39.642839115 230119 0x557ab5d78000 INFO              GST_STATES gstelement.c:2588:_priv_gst_element_state_changed:<pipeline0> notifying about state-changed READY to NULL (VOID_PENDING pending)
Freeing pipeline ...
0:00:39.642849661 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking h264parse0:src(0x557ab5fee830) and kvssink0:video_0(0x557ab5feea80)
0:00:39.642855458 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked h264parse0:src and kvssink0:video_0
0:00:39.642860207 230119 0x557ab5d78000 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<pipeline0> removed child "kvssink0"
0:00:39.642865375 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<kvssink0> 0x557ab60020c0 dispose
0:00:39.642871102 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<kvssink0> removing pad 'video_0'
0:00:39.642875852 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<kvssink0> 0x557ab60020c0 parent class dispose
[INFO ] [25-08-2023 10:59:39:499.765 GMT] Freeing Kinesis Video Stream camera_148
[INFO ] [25-08-2023 10:59:39:499.797 GMT] freeKinesisVideoStream(): Freeing Kinesis Video stream.
[DEBUG] [25-08-2023 10:59:39:499.810 GMT] curlApiCallbacksShutdownActiveRequests(): pActiveRequests hashtable is empty
[INFO ] [25-08-2023 10:59:39:900.074 GMT] freeKinesisVideoClient(): Freeing Kinesis Video Client
[DEBUG] [25-08-2023 10:59:39:900.129 GMT] curlApiCallbacksShutdownActiveRequests(): pActiveRequests hashtable is empty
[DEBUG] [25-08-2023 10:59:40:300.408 GMT] freeKinesisVideoClientInternal(): Total allocated memory 0
[WARN ] [25-08-2023 10:59:40:300.452 GMT] curlApiCallbacksShutdown(): curlApiCallbacksShutdown called when already in progress of shutting down
0:00:40.443640155 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<kvssink0> 0x557ab60020c0 finalize
0:00:40.443655311 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<kvssink0> 0x557ab60020c0 finalize parent
0:00:40.443678638 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2132:gst_pad_unlink: unlinking rtph264depay0:src(0x557ab5fee390) and h264parse0:sink(0x557ab5fee5e0)
0:00:40.443697146 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstpad.c:2187:gst_pad_unlink: unlinked rtph264depay0:src and h264parse0:sink
0:00:40.443709438 230119 0x557ab5d78000 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<pipeline0> removed child "h264parse0"
0:00:40.443724035 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<h264parse0> 0x557ab5ff4460 dispose
0:00:40.443730810 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<h264parse0> removing pad 'sink'
0:00:40.443741775 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<h264parse0> removing pad 'src'
0:00:40.443749807 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<h264parse0> 0x557ab5ff4460 parent class dispose
0:00:40.443767547 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<h264parse0> 0x557ab5ff4460 finalize
0:00:40.443773763 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<h264parse0> 0x557ab5ff4460 finalize parent
0:00:40.443782703 230119 0x557ab5d78000 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<pipeline0> removed child "rtph264depay0"
0:00:40.443791364 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtph264depay0> 0x557ab5fec0e0 dispose
0:00:40.443797161 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtph264depay0> removing pad 'sink'
0:00:40.443806100 230119 0x557ab5d78000 INFO        GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<rtph264depay0> removing pad 'src'
0:00:40.443814202 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtph264depay0> 0x557ab5fec0e0 parent class dispose
0:00:40.443824748 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtph264depay0> 0x557ab5fec0e0 finalize
0:00:40.443830545 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtph264depay0> 0x557ab5fec0e0 finalize parent
0:00:40.443841930 230119 0x557ab5d78000 INFO           GST_PARENTAGE gstbin.c:1801:gst_bin_remove_func:<pipeline0> removed child "rtspsrc0"
0:00:40.443852336 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtspsrc0> 0x557ab5fd6e40 dispose
0:00:40.443858692 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtspsrc0> 0x557ab5fd6e40 parent class dispose
0:00:40.443868609 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtspreal0> 0x557ab5fde080 dispose
0:00:40.443875244 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtspreal0> 0x557ab5fde080 parent class dispose
0:00:40.443884813 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtspreal0> 0x557ab5fde080 finalize
0:00:40.443891099 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtspreal0> 0x557ab5fde080 finalize parent
0:00:40.443897734 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<rtspwms0> 0x557ab5fdb080 dispose
0:00:40.443903810 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<rtspwms0> 0x557ab5fdb080 parent class dispose
0:00:40.443911493 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtspwms0> 0x557ab5fdb080 finalize
0:00:40.443917220 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtspwms0> 0x557ab5fdb080 finalize parent
0:00:40.443926858 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<rtspsrc0> 0x557ab5fd6e40 finalize
0:00:40.443933004 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<rtspsrc0> 0x557ab5fd6e40 finalize parent
0:00:40.443939569 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3264:gst_element_dispose:<pipeline0> 0x557ab6006160 dispose
0:00:40.443958147 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3309:gst_element_dispose:<pipeline0> 0x557ab6006160 parent class dispose
0:00:40.443964713 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3341:gst_element_finalize:<pipeline0> 0x557ab6006160 finalize
0:00:40.443970300 230119 0x557ab5d78000 INFO         GST_REFCOUNTING gstelement.c:3346:gst_element_finalize:<pipeline0> 0x557ab6006160 finalize parent
0:00:40.443976446 230119 0x557ab5d78000 INFO                GST_INIT gst.c:1083:gst_deinit: deinitializing GStreamer
0:00:40.445600493 230119 0x557ab5d78000 INFO                GST_INIT gst.c:1232:gst_deinit: deinitialized GStreamer
sirknightj commented 1 year ago

gst_debug.txt

sirknightj commented 1 year ago

Edited to remove credentials. Please remember to remove credentials when uploading logs. You may also want to redact those credentials and generate new ones.

disa6302 commented 1 year ago

@Mr-MeerMoazzam ,

Have you tested your pipeline with fakesink or other sinks to confirm there isnt an issue with your source pipeline? The issue you are seeing is not related to kvssink since the frames are not getting to kvssink in the first place.

On the other hand, you could trying using this property here: https://gstreamer.freedesktop.org/documentation/rtsp/rtspsrc.html?gi-language=c#rtspsrc:protocols to see if it helps your situation.

You could also use the sample pipeline here: https://github.com/awslabs/amazon-kinesis-video-streams-producer-sdk-cpp/blob/master/docs/linux.md#running-the-gst-launch-10-command-to-start-streaming-from-a-rtsp-camera-source and replace your RTSP URL to see if it helps the issue.

Resolving since this is not kvssink specific. Feel free to open a new issue or start a discussion thread if you still face issues after trying out the suggestions.