Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Source Second Path (v1.37.50 ) Stream reading problems #3815

Open
IgorA100 opened this issue Feb 5, 2024 · 3 comments
Open

Source Second Path (v1.37.50 ) Stream reading problems #3815

IgorA100 opened this issue Feb 5, 2024 · 3 comments

Comments

@IgorA100
Copy link
Contributor

IgorA100 commented Feb 5, 2024

Describe Your Environment

  • Version of ZoneMinder - 1.37.50
  • How you installed ZoneMinder - PPA (Updated 03 feb 24)
  • Full name and version of OS - Ubuntu 23.10 mantic

If the issue concerns a camera

  • Make and Model - Beward SV5017RBZ
  • Source Path - rtsp://192.168.111.20:554/main
  • Method - TCP
  • Decoding - On Demand
  • SourceSecondPath - rtsp://admin:admin@192.168.111.20:554/third
  • Motion Detection -None

Describe the bug
The second stream is not readable.
At the same time, if I change the first stream with the second in the monitor settings, then the second stream (which was previously the first and was read without problems) is not readable again.
If for the second thread I specify:
SourceSecondPath - rtsp://192.168.111.20:554/third
A 401 authorization error follows.
It's likely that different algorithms are used to start reading the first and second streams.

Expected behavior

  1. The second stream must be read.
  2. It is also not clear whether it is necessary to specify a name and password in the second stream.
    On my other camera model the second thread is listed as:
    SourceSecondPath - rtsp://192.168.111.25:80/1
    and it works!
Debug Logs

Debug Logs for rtsp://admin:admin@192.168.111.20:554/third


02/05/24 14:39:44.811734 zmc_m6[15941].DB1-zm_logger.cpp/225 [LogOpts: level=DB3 effective=DB3, screen=OFF, database=INF, logfile=DB3->/var/log/zm/_debug.15941, syslog=INF]
02/05/24 14:39:44.811925 zmc_m6[15941].DB1-zm_utils.cpp/231 [Detected a x86\x86-64 processor with AVX]
02/05/24 14:39:44.813329 zmc_m6[15941].DB2-zm_storage.cpp/61 [Loading Storage for 4 using SELECT `Id`, `Name`, `Path`, `Type`, `Scheme` FROM `Storage` WHERE `Id`=4]
02/05/24 14:39:44.813607 zmc_m6[15941].DB1-zm_storage.cpp/79 [Loaded Storage area 4 'NewStorageBIG']
02/05/24 14:39:44.813635 zmc_m6[15941].DB1-zm_monitor.cpp/397 [Have camera type Ffmpeg]
02/05/24 14:39:44.813667 zmc_m6[15941].DB3-zm_monitor.cpp/489 [Decoding: 2 savejpegs 0 videowriter 2]
02/05/24 14:39:44.813688 zmc_m6[15941].DB1-zm_packetqueue.cpp/739 [Setting pre_event_video_packet_count to 5]
02/05/24 14:39:44.813702 zmc_m6[15941].DB1-zm_packetqueue.cpp/733 [Setting max_video_packet_count to 121]
02/05/24 14:39:44.813739 zmc_m6[15941].DB2-zm_camera.cpp/69 [New camera id: 6 width: 640 line size: 2560 height: 360 colours: 4 subpixelorder: 8 capture: 1, size: 921600]
02/05/24 14:39:44.813783 zmc_m6[15941].INF-zm_ffmpeg.cpp/83 [Enabling ffmpeg logs, as LOG_DEBUG+LOG_FFMPEG are enabled in options]
02/05/24 14:39:44.814039 zmc_m6[15941].DB2-zmc.cpp/218 [1 monitors loaded]
02/05/24 14:39:44.814063 zmc_m6[15941].INF-zmc.cpp/221 [Starting Capture version 1.37.50]
02/05/24 14:39:44.814128 zmc_m6[15941].DB3-zm_monitor.cpp/2452 [Reloading zones for monitor Camera_8Mp have 0]
02/05/24 14:39:44.816033 zmc_m6[15956].DB1-zm_db.cpp/205 [Success running sql query INSERT INTO `Logs` ( `TimeKey`, `Component`, `ServerId`, `Pid`, `Level`, `Code`, `Message`, `File`, `Line` ) VALUES ( 1707133184.813783, 'zmc_m6', 0, 15941, 0, 'INF', 'Enabling ffmpeg logs, as LOG_DEBUG+LOG_FFMPEG are enabled in options', 'zm_ffmpeg.cpp', 83 ), thread_id: 2746]
02/05/24 14:39:44.817939 zmc_m6[15956].DB1-zm_db.cpp/205 [Success running sql query INSERT INTO `Logs` ( `TimeKey`, `Component`, `ServerId`, `Pid`, `Level`, `Code`, `Message`, `File`, `Line` ) VALUES ( 1707133184.814063, 'zmc_m6', 0, 15941, 0, 'INF', 'Starting Capture version 1.37.50', 'zmc.cpp', 221 ), thread_id: 2746]
02/05/24 14:39:44.818477 zmc_m6[15941].DB1-zm_zone.cpp/844 [Got 1 zones for monitor Camera_8Mp]
02/05/24 14:39:44.818505 zmc_m6[15941].DB3-zm_zone.cpp/770 [Got coordinate 0,0 from polygon string]
02/05/24 14:39:44.818520 zmc_m6[15941].DB3-zm_zone.cpp/770 [Got coordinate 639,0 from polygon string]
02/05/24 14:39:44.818532 zmc_m6[15941].DB3-zm_zone.cpp/770 [Got coordinate 639,359 from polygon string]
02/05/24 14:39:44.818545 zmc_m6[15941].DB3-zm_zone.cpp/770 [Got coordinate 0,359 from polygon string]
02/05/24 14:39:44.818558 zmc_m6[15941].DB3-zm_zone.cpp/782 [Successfully parsed polygon string 0,359]
02/05/24 14:39:44.819415 zmc_m6[15941].DB1-zm_monitor.cpp/2454 [Reloading zones for monitor Camera_8Mp have 1]
02/05/24 14:39:44.819443 zmc_m6[15941].DB1-zm_monitor.cpp/855 [SharedData=856 TriggerData=560 zone_count 1 * sizeof int 4 VideoStoreData=4128 timestamps=80 images=5x921600 = 4608000 analysis images=5x921600 = 4608000 image_format = 5x4 = 20 total=9221712]
02/05/24 14:39:44.819488 zmc_m6[15941].DB3-zm_monitor.cpp/888 [Success opening mmap file at (/dev/shm/zm.mmap.6)]
02/05/24 14:39:44.819517 zmc_m6[15941].DB3-zm_monitor.cpp/921 [MMap file size is 0]
02/05/24 14:39:44.834562 zmc_m6[15941].DB3-zm_monitor.cpp/964 [Aligning shared memory images to the next 64 byte boundary 0x7fea2752d5fc to 0x7fea2752d600 moved 4 bytes]
02/05/24 14:39:44.836285 zmc_m6[15941].DB1-zm_monitor.cpp/2460 [Reloading linked monitors for monitor Camera_8Mp, '']
02/05/24 14:39:44.836322 zmc_m6[15941].DB1-zm_monitor.cpp/1147 [Not Starting ONVIF]
02/05/24 14:39:44.836341 zmc_m6[15941].DB3-zm_monitor.cpp/1168 [Success connecting]
02/05/24 14:39:44.838714 zmc_m6[15941].DB1-zm_db.cpp/205 [Success running sql query INSERT INTO Monitor_Status (MonitorId,Status,CaptureFPS,AnalysisFPS,CaptureBandwidth) VALUES (6, 'Running',0,0,0) ON DUPLICATE KEY UPDATE Status='Running',CaptureFPS=0,AnalysisFPS=0,CaptureBandwidth=0, thread_id: 2746]
02/05/24 14:39:44.838764 zmc_m6[15941].DB1-zm_ffmpeg_camera.cpp/177 [Priming capture from rtsp://192.168.111.20:554/main]
02/05/24 14:39:44.838799 zmc_m6[15941].DB1-zm_ffmpeg_camera.cpp/344 [Calling avformat_open_input for rtsp://192.168.111.20:554/main]
02/05/24 14:39:44.838858 zmc_m6[15941].DB1-zm_ffmpeg_camera.cpp/354 [Rebuilt URI with encoded parameters: 'rtsp://admin:admin@192.168.111.20:554/main']
02/05/24 14:39:44.839061 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [No default whitelist set]
02/05/24 14:39:44.839106 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Original list of addresses:]
02/05/24 14:39:44.839132 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Address 192.168.111.20 port 554]
02/05/24 14:39:44.839146 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Interleaved list of addresses:]
02/05/24 14:39:44.839160 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Address 192.168.111.20 port 554]
02/05/24 14:39:44.839174 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [Starting connection attempt to 192.168.111.20 port 554]
02/05/24 14:39:44.839923 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [Successfully connected to 192.168.111.20 port 554]
02/05/24 14:39:44.869243 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [SDP:
v=0
o=- 1707131996110231 1 IN IP4 192.168.111.20
s=RTSP/RTP stream from IPNC
i=main
t=0 0
a=tool:LIVE555 Streaming Media v2010.07.29
a=type:broadcast
a=control:*
a=range:npt=0-
a=x-qt-text-nam:RTSP/RTP stream from IPNC
a=x-qt-text-inf:main
m=video 0 RTP/AVP 96
b=AS:12000
a=rtpmap:96 H264/90000
a=fmtp:96 packetization-mode=1;profile-level-id=420033;sprop-parameter-sets=Z0IAM5Y1QHgAh9NwEBAQIA==,aM4xsg==
a=recvonly
a=control:track1
m=application 0 RTP/AVP 98
b=AS:0
a=rtpmap:98 vnd.onvif.metadata/90000
a=recvonly
a=control:track2
]
02/05/24 14:39:44.869292 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Failed to parse interval end specification '']
02/05/24 14:39:44.869395 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [video codec set to: h264]
02/05/24 14:39:44.869418 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [RTP Packetization Mode: 1]
02/05/24 14:39:44.869434 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [RTP Profile IDC: 42 Profile IOP: 0 Level: 33]
02/05/24 14:39:44.869452 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Extradata set to 0x55f113722440 (size: 28)]
02/05/24 14:39:44.874022 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [setting jitter buffer size to 0]
02/05/24 14:39:44.877416 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [setting jitter buffer size to 0]
02/05/24 14:39:44.877448 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [hello state=0]
02/05/24 14:39:44.883437 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Failed to parse interval end specification '']
02/05/24 14:39:44.887343 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 7(SPS), nal_ref_idc: 3]
02/05/24 14:39:44.887371 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 8(PPS), nal_ref_idc: 3]
02/05/24 14:39:44.887403 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:44.939309 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 7(SPS), nal_ref_idc: 3]
02/05/24 14:39:44.939341 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 8(PPS), nal_ref_idc: 3]
02/05/24 14:39:44.939376 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:44.994006 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:44.994046 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Format yuvj420p chosen by get_format().]
02/05/24 14:39:44.994066 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [Reinit context to 3840x2160, pix_fmt: yuvj420p]
02/05/24 14:39:44.999159 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Frame num gap 20 18]
02/05/24 14:39:45.087868 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.177019 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.232095 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.273710 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.357690 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.419473 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.465132 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.544129 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.617589 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.838679 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:45.838907 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [unknown SEI type 229]
02/05/24 14:39:45.842615 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 7(SPS), nal_ref_idc: 3]
02/05/24 14:39:45.842650 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 8(PPS), nal_ref_idc: 3]
02/05/24 14:39:45.842688 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 6(SEI), nal_ref_idc: 0]
02/05/24 14:39:45.843068 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 5(IDR), nal_ref_idc: 3]
02/05/24 14:39:45.843120 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:45.843503 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [unknown SEI type 229]
02/05/24 14:39:45.922946 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.948891 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:45.984976 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:46.017790 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:46.047984 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:46.076540 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:47.397543 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Probe buffer size limit of 5000000 bytes reached]
02/05/24 14:39:47.397592 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [Ignoring outlier non primary stream starttime 0.000000]
02/05/24 14:39:47.404352 zmc_m6[15941].DB2-zm_ffmpeg.cpp/367 [Not a video type 2 != 0]
02/05/24 14:39:47.404382 zmc_m6[15941].DB3-zm_ffmpeg_camera.cpp/414 [Found video stream at index 0, audio stream at index -1]
02/05/24 14:39:47.404598 zmc_m6[15941].DB1-zm_ffmpeg.cpp/246 [Dumping stream index i(0) index(0)]
02/05/24 14:39:47.404617 zmc_m6[15941].DB1-zm_ffmpeg.cpp/252 [    Stream #0:0]
02/05/24 14:39:47.404631 zmc_m6[15941].DB1-zm_ffmpeg.cpp/260 [frame_size:0 stream timebase: 1/90000]
02/05/24 14:39:47.404644 zmc_m6[15941].DB1-zm_ffmpeg.cpp/265 [codec: h264 video]
02/05/24 14:39:47.404658 zmc_m6[15941].DB1-zm_ffmpeg.cpp/283 [, SAR 0:1 ]
02/05/24 14:39:47.404672 zmc_m6[15941].DB1-zm_ffmpeg.cpp/177 [90k stream tb numerator]
02/05/24 14:39:47.404730 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 7(SPS), nal_ref_idc: 3]
02/05/24 14:39:47.404750 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 8(PPS), nal_ref_idc: 3]
02/05/24 14:39:47.404767 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:47.404835 zmc_m6[15941].DB1-zm_ffmpeg_camera.cpp/548 [Thread count? 1]
02/05/24 14:39:47.404879 zmc_m6[15941].DB1-zm_ffmpeg.cpp/215 [Dumping codec_context codec_type 0 video codec_id 27 h264 width 3840 height 2160 timebase 0/1 format yuvj420p profile 66 level 51 gop_size 12 has_b_frames 0 max_b_frames 0 me_cmp 0 me_range 0 qmin 2 qmax 31 bit_rate 0 extradata:28:0000000167420033963540780087d370101010200000000168ce31b2]
02/05/24 14:39:47.404900 zmc_m6[15941].DB1-zm_ffmpeg_camera.cpp/567 [Trying secondary stream at rtsp://admin:admin@192.168.111.20:554/third]
02/05/24 14:39:47.404972 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [No default whitelist set]
02/05/24 14:39:47.405000 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Original list of addresses:]
02/05/24 14:39:47.405032 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Address 192.168.111.20 port 554]
02/05/24 14:39:47.405048 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Interleaved list of addresses:]
02/05/24 14:39:47.405062 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Address 192.168.111.20 port 554]
02/05/24 14:39:47.405076 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [Starting connection attempt to 192.168.111.20 port 554]
02/05/24 14:39:47.410657 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [Successfully connected to 192.168.111.20 port 554]
02/05/24 14:39:47.433598 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [SDP:
v=0
o=- 1707131996114717 1 IN IP4 192.168.111.20
s=RTSP/RTP stream from IPNC
i=third
t=0 0
a=tool:LIVE555 Streaming Media v2010.07.29
a=type:broadcast
a=control:*
a=range:npt=0-
a=x-qt-text-nam:RTSP/RTP stream from IPNC
a=x-qt-text-inf:third
m=video 0 RTP/AVP 96
b=AS:12000
a=rtpmap:96 H264/90000
a=fmtp:96 packetization-mode=1;profile-level-id=420029;sprop-parameter-sets=Z0IAKZY1QPAET8s3AQEBAg==,aM4xsg==
a=recvonly
a=control:track1
m=application 0 RTP/AVP 98
b=AS:0
a=rtpmap:98 vnd.onvif.metadata/90000
a=recvonly
a=control:track2
]
02/05/24 14:39:47.433636 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Failed to parse interval end specification '']
02/05/24 14:39:47.433672 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [video codec set to: h264]
02/05/24 14:39:47.433693 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [RTP Packetization Mode: 1]
02/05/24 14:39:47.433708 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [RTP Profile IDC: 42 Profile IOP: 0 Level: 29]
02/05/24 14:39:47.433725 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Extradata set to 0x55f113906d00 (size: 28)]
02/05/24 14:39:47.433798 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [No default whitelist set]
02/05/24 14:39:47.433862 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [No default whitelist set]
02/05/24 14:39:47.433950 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [end receive buffer size reported is 425984]
02/05/24 14:39:47.434009 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [No default whitelist set]
02/05/24 14:39:47.434067 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [end receive buffer size reported is 425984]
02/05/24 14:39:47.437133 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [setting jitter buffer size to 500]
02/05/24 14:39:47.437177 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [No default whitelist set]
02/05/24 14:39:47.437217 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [No default whitelist set]
02/05/24 14:39:47.437264 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [end receive buffer size reported is 425984]
02/05/24 14:39:47.437310 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [No default whitelist set]
02/05/24 14:39:47.437363 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [end receive buffer size reported is 425984]
02/05/24 14:39:47.440445 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [setting jitter buffer size to 500]
02/05/24 14:39:47.440476 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [hello state=0]
02/05/24 14:39:47.442318 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Failed to parse interval end specification '']
02/05/24 14:39:47.444060 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 7(SPS), nal_ref_idc: 3]
02/05/24 14:39:47.444089 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 8(PPS), nal_ref_idc: 3]
02/05/24 14:39:47.444108 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:47.479098 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 7(SPS), nal_ref_idc: 3]
02/05/24 14:39:47.479126 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 8(PPS), nal_ref_idc: 3]
02/05/24 14:39:47.479145 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:47.555045 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:47.555089 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Format yuvj420p chosen by get_format().]
02/05/24 14:39:47.555118 zmc_m6[15941].DB2-zm_ffmpeg.cpp/68 [Reinit context to 1920x1088, pix_fmt: yuvj420p]
02/05/24 14:39:47.556054 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Frame num gap 26 24]
02/05/24 14:39:47.613232 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:47.658680 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:47.744476 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:47.815726 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:47.816036 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [unknown SEI type 229]
02/05/24 14:39:47.816958 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 7(SPS), nal_ref_idc: 3]
02/05/24 14:39:47.816984 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 8(PPS), nal_ref_idc: 3]
02/05/24 14:39:47.817000 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 6(SEI), nal_ref_idc: 0]
02/05/24 14:39:47.817112 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 5(IDR), nal_ref_idc: 3]
02/05/24 14:39:47.817138 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:47.817201 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [unknown SEI type 229]
02/05/24 14:39:47.835933 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:47.874742 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:48.003713 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:48.055973 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:48.096909 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:48.201965 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 3]
02/05/24 14:39:49.609662 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [All info found]
02/05/24 14:39:49.609809 zmc_m6[15941].DB2-zm_ffmpeg_input.cpp/62 [Have 2 streams]
02/05/24 14:39:49.609836 zmc_m6[15941].DB1-zm_ffmpeg.cpp/246 [Dumping stream index i(0) index(0)]
02/05/24 14:39:49.609851 zmc_m6[15941].DB1-zm_ffmpeg.cpp/252 [    Stream #0:0]
02/05/24 14:39:49.609863 zmc_m6[15941].DB1-zm_ffmpeg.cpp/260 [frame_size:0 stream timebase: 1/90000]
02/05/24 14:39:49.609875 zmc_m6[15941].DB1-zm_ffmpeg.cpp/265 [codec: h264 video]
02/05/24 14:39:49.609889 zmc_m6[15941].DB1-zm_ffmpeg.cpp/283 [, SAR 0:1 ]
02/05/24 14:39:49.609903 zmc_m6[15941].DB1-zm_ffmpeg.cpp/177 [90k stream tb numerator]
02/05/24 14:39:49.609944 zmc_m6[15941].DB1-zm_ffmpeg_input.cpp/91 [Using codec (h264) for stream 0]
02/05/24 14:39:49.610169 zmc_m6[15941].DB1-zm_ffmpeg.cpp/215 [Dumping codec_context codec_type 0 video codec_id 27 h264 width 1920 height 1080 timebase 0/1 format yuvj420p profile 66 level 41 gop_size 12 has_b_frames 0 max_b_frames 0 me_cmp 0 me_range 0 qmin 2 qmax 31 bit_rate 0 extradata:28:0000000167420029963540f0044fcb37010101020000000168ce31b2]
02/05/24 14:39:49.610239 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 7(SPS), nal_ref_idc: 3]
02/05/24 14:39:49.610260 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [nal_unit_type: 8(PPS), nal_ref_idc: 3]
02/05/24 14:39:49.610276 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:49.610336 zmc_m6[15941].DB1-zm_ffmpeg.cpp/215 [Dumping codec_context codec_type 0 video codec_id 27 h264 width 1920 height 1080 timebase 0/1 format yuvj420p profile 66 level 41 gop_size 12 has_b_frames 0 max_b_frames 0 me_cmp 0 me_range 0 qmin 2 qmax 31 bit_rate 0 extradata:28:0000000167420029963540f0044fcb37010101020000000168ce31b2]
02/05/24 14:39:49.610354 zmc_m6[15941].DB1-zm_ffmpeg_input.cpp/109 [Setting to default time base]
02/05/24 14:39:49.610368 zmc_m6[15941].DB2-zm_ffmpeg.cpp/367 [Not a video type 2 != 0]
02/05/24 14:39:49.610382 zmc_m6[15941].WAR-zm_ffmpeg_input.cpp/81 [Unknown stream type]
02/05/24 14:39:49.610472 zmc_m6[15941].ERR-zm_ffmpeg_input.cpp/87 [Could not find input codec]
02/05/24 14:39:49.610728 zmc_m6[15941].WAR-zm_ffmpeg_camera.cpp/575 [Failed to open secondary input]
02/05/24 14:39:49.610772 zmc_m6[15941].DB1-zm_ffmpeg_camera.cpp/584 [Monitor dimensions are 640x360 but camera is sending 3840x2160]
02/05/24 14:39:49.610806 zmc_m6[15941].DB2-zm_monitor.cpp/3316 [Video stream id is 0, audio is -1, minimum_packets to keep in buffer 5]
02/05/24 14:39:49.610824 zmc_m6[15941].DB1-zm_packetqueue.cpp/695 [Didn't find a keyframe for stream 0, so returning the it to it]
02/05/24 14:39:49.610841 zmc_m6[15941].DB1-zm_monitor.cpp/3358 [Creating decoder thread]
02/05/24 14:39:49.611109 zmc_m6[15941].DB1-zm_monitor.cpp/3365 [Done restarting decoder]
02/05/24 14:39:49.611136 zmc_m6[15941].DB1-zm_monitor.cpp/3367 [getting analysis_it]
02/05/24 14:39:49.611151 zmc_m6[16018].DB2-zm_decoder_thread.cpp/27 [DecoderThread::Run() for 6]
02/05/24 14:39:49.611213 zmc_m6[15941].DB1-zm_packetqueue.cpp/695 [Didn't find a keyframe for stream 0, so returning the it to it]
02/05/24 14:39:49.611252 zmc_m6[15941].DB1-zm_monitor.cpp/3373 [Starting an analysis thread for monitor (6)]
02/05/24 14:39:49.611275 zmc_m6[16018].DB2-zm_packetqueue.cpp/521 [waiting.  Queue size 0 it == end? 1]
02/05/24 14:39:49.611520 zmc_m6[16019].DB2-zm_packetqueue.cpp/475 [waiting.  Queue size 0 it == end? 1]
02/05/24 14:39:49.612569 zmc_m6[15956].DB1-zm_db.cpp/205 [Success running sql query INSERT INTO `Logs` ( `TimeKey`, `Component`, `ServerId`, `Pid`, `Level`, `Code`, `Message`, `File`, `Line` ) VALUES ( 1707133189.610382, 'zmc_m6', 0, 15941, -1, 'WAR', 'Unknown stream type', 'zm_ffmpeg_input.cpp', 81 ), thread_id: 2746]
02/05/24 14:39:49.613917 zmc_m6[15956].DB1-zm_db.cpp/205 [Success running sql query INSERT INTO `Logs` ( `TimeKey`, `Component`, `ServerId`, `Pid`, `Level`, `Code`, `Message`, `File`, `Line` ) VALUES ( 1707133189.610472, 'zmc_m6', 0, 15941, -2, 'ERR', 'Could not find input codec', 'zm_ffmpeg_input.cpp', 87 ), thread_id: 2746]
02/05/24 14:39:49.615408 zmc_m6[15956].DB1-zm_db.cpp/205 [Success running sql query INSERT INTO `Logs` ( `TimeKey`, `Component`, `ServerId`, `Pid`, `Level`, `Code`, `Message`, `File`, `Line` ) VALUES ( 1707133189.610728, 'zmc_m6', 0, 15941, -1, 'WAR', 'Failed to open secondary input', 'zm_ffmpeg_camera.cpp', 575 ), thread_id: 2746]
02/05/24 14:39:49.617026 zmc_m6[15941].DB1-zm_db.cpp/205 [Success running sql query INSERT INTO Monitor_Status (MonitorId,Status) VALUES (6, 'Connected') ON DUPLICATE KEY UPDATE Status='Connected', thread_id: 2746]
02/05/24 14:39:49.620222 zmc_m6[15941].DB2-zm_ffmpeg_camera.cpp/252 [ffmpeg_camera in: pts: 219600 * 1/90000=2.440000, dts: 219600, size: 111778, stream_index: 0, video flags: 0000, keyframe(0) pos: -1, duration: 3600]
02/05/24 14:39:49.620257 zmc_m6[15941].DB2-zm_monitor.cpp/2625 [Have packet stream_index:0 ?= videostream_id: 0 q.vpktcount 0 event? 0 image_count 0]
02/05/24 14:39:49.623351 zmc_m6[15941].DB2-zm_ffmpeg_camera.cpp/252 [ffmpeg_camera in: pts: 293318 * 1/90000=3.259089, dts: 293318, size: 73, stream_index: 1, data flags: 0001, keyframe(1) pos: -1, duration: 0]
02/05/24 14:39:49.623390 zmc_m6[15941].DB2-zm_monitor.cpp/2625 [Have packet stream_index:1 ?= videostream_id: 0 q.vpktcount 0 event? 0 image_count 1]
02/05/24 14:39:49.623409 zmc_m6[15941].DB1-zm_monitor.cpp/2657 [Unknown codec type 2 data]
02/05/24 14:39:49.623511 zmc_m6[15941].DB2-zm_ffmpeg_camera.cpp/252 [ffmpeg_camera in: pts: 227070 * 1/90000=2.523000, dts: 227070, size: 116549, stream_index: 0, video flags: 0000, keyframe(0) pos: -1, duration: 3600]
02/05/24 14:39:49.623543 zmc_m6[15941].DB2-zm_monitor.cpp/2625 [Have packet stream_index:0 ?= videostream_id: 0 q.vpktcount 0 event? 0 image_count 1]
02/05/24 14:39:49.626598 zmc_m6[15941].DB2-zm_ffmpeg_camera.cpp/252 [ffmpeg_camera in: pts: 234000 * 1/90000=2.600000, dts: 234000, size: 115625, stream_index: 0, video flags: 0000, keyframe(0) pos: -1, duration: 3600]
02/05/24 14:39:49.626627 zmc_m6[15941].DB2-zm_monitor.cpp/2625 [Have packet stream_index:0 ?= videostream_id: 0 q.vpktcount 0 event? 0 image_count 2]
02/05/24 14:39:49.653512 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [Decoding VUI]
02/05/24 14:39:49.653592 zmc_m6[15941].DB3-zm_ffmpeg.cpp/68 [unknown SEI type 229]
02/05/24 14:39:49.653715 zmc_m6[15941].DB2-zm_ffmpeg_camera.cpp/252 [ffmpeg_camera in: pts: 237600 * 1/90000=2.640000, dts: 237600, size: 951097, stream_index: 0, video flags: 0001, keyframe(1) pos: -1, duration: 3600]
02/05/24 14:39:49.653777 zmc_m6[15941].DB2-zm_monitor.cpp/2625 [Have packet stream_index:0 ?= videostream_id: 0 q.vpktcount 0 event? 0 image_count 3]
02/05/24 14:39:49.653804 zmc_m6[15941].DB1-zm_packetqueue.cpp/123 [Have keyframe interval: 0]
02/05/24 14:39:49.653820 zmc_m6[15941].DB2-zm_packetqueue.cpp/142 [packet counts for 0 is 1]
02/05/24 14:39:49.653875 zmc_m6[16018].DB3-zm_packetqueue.cpp/531 [get_packet using it 0x55f11370ec80 locking index 3]
02/05/24 14:39:49.653975 zmc_m6[16018].DB2-zm_packetqueue.cpp/536 [Locked packet 3, unlocking packetqueue mutex, incrementing it]
02/05/24 14:39:49.654033 zmc_m6[16018].DB3-zm_monitor.h/739 [Last viewed 1707133189 seconds ago]
02/05/24 14:39:49.654073 zmc_m6[16018].DB1-zm_monitor.cpp/2792 [Not Decoding ? On demand]
02/05/24 14:39:49.654113 zmc_m6[16019].DB3-zm_packetqueue.cpp/485 [get_packet using it 0x55f113723fe0 locking index 3]
02/05/24 14:39:49.654207 zmc_m6[16019].DB2-zm_packetqueue.cpp/490 [Locked packet 3, unlocking packetqueue mutex]
02/05/24 14:39:49.654250 zmc_m6[16019].DB3-zm_monitor.cpp/1966 [Motion detection is enabled?(1) signal(1) signal_change(0) trigger state(Cancel) image index 3]
02/05/24 14:39:49.654274 zmc_m6[16018].DB2-zm_packetqueue.cpp/521 [waiting.  Queue size 1 it == end? 1]
02/05/24 14:39:49.654330 zmc_m6[16019].DB1-zm_monitor.cpp/2196 [Not analysing 1]
02/05/24 14:39:49.654359 zmc_m6[16019].DB1-zm_monitor.cpp/2240 [!score state=IDLE]
02/05/24 14:39:49.654385 zmc_m6[16019].DB1-zm_monitor.cpp/2262 [State 1 IDLE because analysis_image_count(0)-last_alarm_count(0) = 0 > post_event_count(5) and timestamp.tv_sec(1707133189) - recording.tv_src(0) >= min_section_length(10)]
02/05/24 14:39:49.654401 zmc_m6[16019].DB2-zm_monitor.cpp/3002 [First packet from alarm: pts: 237600, dts: 237600, size: 951097, stream_index: 0, flags: 0001, keyframe(1) pos: -1, duration: 3600]
02/05/24 14:39:49.655534 zmc_m6[15941].DB2-zm_ffmpeg_camera.cpp/252 [ffmpeg_camera in: pts: 248400 * 1/90000=2.760000, dts: 248400, size: 56952, stream_index: 0, video flags: 0000, keyframe(0) pos: -1, duration: 3600]
02/05/24 14:39:49.655567 zmc_m6[15941].DB2-zm_monitor.cpp/2625 [Have packet stream_index:0 ?= videostream_id: 0 q.vpktcount 1 event? 0 image_count 4]
02/05/24 14:39:49.655581 zmc_m6[15941].DB2-zm_packetqueue.cpp/142 [packet counts for 0 is 2]
02/05/24 14:39:49.655628 zmc_m6[16018].DB3-zm_packetqueue.cpp/531 [get_packet using it 0x55f11370ec80 locking index 4]
02/05/24 14:39:49.655654 zmc_m6[16018].DB2-zm_packetqueue.cpp/536 [Locked packet 4, unlocking packetqueue mutex, incrementing it]
02/05/24 14:39:49.655672 zmc_m6[16018].DB3-zm_monitor.h/739 [Last viewed 1707133189 seconds ago]
02/05/24 14:39:49.655685 zmc_m6[16018].DB1-zm_monitor.cpp/2792 [Not Decoding ? On demand]
02/05/24 14:39:49.655700 zmc_m6[16018].DB2-zm_packetqueue.cpp/521 [waiting.  Queue size 2 it == end? 1]
02/05/24 14:39:49.657029 zmc_m6[15941].DB2-zm_ffmpeg_camera.cpp/252 [ffmpeg_camera in: pts: 252000 * 1/90000=2.800000, dts: 252000, size: 43202, stream_index: 0, video flags: 0000, keyframe(0) pos: -1, duration: 3600]
02/05/24 14:39:49.657059 zmc_m6[15941].DB2-zm_monitor.cpp/2625 [Have packet stream_index:0 ?= videostream_id: 0 q.vpktcount 2 event? 0 image_count 5]
02/05/24 14:39:49.657079 zmc_m6[15941].DB2-zm_packetqueue.cpp/142 [packet counts for 0 is 3]
02/05/24 14:39:49.657197 zmc_m6[16018].DB3-zm_packetqueue.cpp/531 [get_packet using it 0x55f11370ec80 locking index 5]
02/05/24 14:39:49.657223 zmc_m6[16018].DB2-zm_packetqueue.cpp/536 [Locked packet 5, unlocking packetqueue mutex, incrementing it]
02/05/24 14:39:49.657240 zmc_m6[16018].DB3-zm_monitor.h/739 [Last viewed 1707133189 seconds ago]
02/05/24 14:39:49.657253 zmc_m6[16018].DB1-zm_monitor.cpp/2792 [Not Decoding ? On demand]
02/05/24 14:39:49.657267 zmc_m6[16018].DB2-zm_packetqueue.cpp/521 [waiting.  Queue size 3 it == end? 1]
02/05/24 14:39:49.658447 zmc_m6[16019].DB2-zm_db.cpp/225 [Success running sql insert INSERT INTO `Events` ( `MonitorId`, `StorageId`, `Name`, `StartDateTime`, `Width`, `Height`, `Cause`, `Notes`, `StateId`, `Orientation`, `Videoed`, `DefaultVideo`, `SaveJPEGs`, `Scheme`, `Latitude`, `Longitude` ) VALUES ( 6, 4, 'New Event', from_unixtime(1707133189), 640, 360, 'Continuous', '', 1, 1, 0, 'incomplete.mp4', 0, 'Medium', '0.000000', '0.000000' ). Resulting id is 10645]
02/05/24 14:39:49.658741 zmc_m6[16019].INF-zm_monitor.cpp/2367 [Opened new event 10645 Continuous]
02/05/24 14:39:49.658839 zmc_m6[16019].DB3-zm_packetqueue.cpp/246 [stream index 0 ?= video_stream_id 0, keyframe 1, keep_keyframes 1,  counts 3 > pre_event_count 5 at begin 0]
02/05/24 14:39:49.658888 zmc_m6[16019].DB2-zm_packetqueue.cpp/560 [Incrementing 0x55f113723fe0, queue size 3, end? 0, deleting 0]
02/05/24 14:39:49.658910 zmc_m6[16019].DB2-zm_packetqueue.cpp/567 [Incrementing 0x55f113723fe0, 0x55f113723fe0 still not at end, so returning true]
02/05/24 14:39:49.658924 zmc_m6[16019].DB3-zm_packetqueue.cpp/485 [get_packet using it 0x55f113723fe0 locking index 4]
02/05/24 14:39:49.658940 zmc_m6[16019].DB2-zm_packetqueue.cpp/490 [Locked packet 4, unlocking packetqueue mutex]
02/05/24 14:39:49.658953 zmc_m6[16019].DB3-zm_monitor.cpp/1966 [Motion detection is enabled?(1) signal(1) signal_change(0) trigger state(Cancel) image index 4]
02/05/24 14:39:49.659010 zmc_m6[16019].DB1-zm_monitor.cpp/2196 [Not analysing 1]
02/05/24 14:39:49.659039 zmc_m6[16019].DB1-zm_monitor.cpp/2240 [!score state=IDLE]
02/05/24 14:39:49.659053 zmc_m6[15941].DB2-zm_ffmpeg_camera.cpp/252 [ffmpeg_camera in: pts: 255600 * 1/90000=2.840000, dts: 255600, size: 68967, stream_index: 0, video flags: 0000, keyframe(0) pos: -1, duration: 3600]
02/05/24 14:39:49.659103 zmc_m6[15941].DB2-zm_monitor.cpp/2625 [Have packet stream_index:0 ?= videostream_id: 0 q.vpktcount 3 event? 1 image_count 6]
02/05/24 14:39:49.659123 zmc_m6[15941].DB2-zm_packetqueue.cpp/142 [packet counts for 0 is 4]
02/05/24 14:39:49.659166 zmc_m6[16020].DB1-zm_event.cpp/639 [Using storage area at /mnt/videoNEW/6/2024-02-05/10645]
02/05/24 14:39:49.659216 zmc_m6[16020].DB1-zm_videostore.cpp/117 [Opening video storage stream /mnt/videoNEW/6/2024-02-05/10645/incomplete.mp4 format: mp4]
02/05/24 14:39:49.659324 zmc_m6[16018].DB3-zm_packetqueue.cpp/531 [get_packet using it 0x55f11370ec80 locking index 6]
02/05/24 14:39:49.659362 zmc_m6[16018].DB2-zm_packetqueue.cpp/536 [Locked packet 6, unlocking packetqueue mutex, incrementing it]
02/05/24 14:39:49.659395 zmc_m6[16018].DB3-zm_monitor.h/739 [Last viewed 1707133189 seconds ago]
02/05/24 14:39:49.659474 zmc_m6[16018].DB1-zm_monitor.cpp/2792 [Not Decoding ? On demand]
02/05/24 14:39:49.659515 zmc_m6[16018].DB2-zm_packetqueue.cpp/521 [waiting.  Queue size 4 it == end? 1]
02/05/24 14:39:49.659787 zmc_m6[16019].DB1-zm_monitor.cpp/2262 [State 1 IDLE because analysis_image_count(1)-last_alarm_count(0) = 1 > post_event_count(5) and timestamp.tv_sec(1707133189) - recording.tv_src(1707133189) >= min_section_length(10)]
02/05/24 14:39:49.659826 zmc_m6[16019].DB3-zm_packetqueue.cpp/246 [stream index 0 ?= video_stream_id 0, keyframe 0, keep_keyframes 1,  counts 4 > pre_event_count 5 at begin 1]
02/05/24 14:39:49.659851 zmc_m6[16019].DB2-zm_packetqueue.cpp/560 [Incrementing 0x55f113723fe0, queue size 4, end? 0, deleting 0]
02/05/24 14:39:49.659875 zmc_m6[16019].DB2-zm_packetqueue.cpp/567 [Incrementing 0x55f113723fe0, 0x55f113723fe0 still not at end, so returning true]
02/05/24 14:39:49.659914 zmc_m6[16019].DB3-zm_packetqueue.cpp/485 [get_packet using it 0x55f113723fe0 locking index 5]
02/05/24 14:39:49.659939 zmc_m6[16019].DB2-zm_packetqueue.cpp/490 [Locked packet 5, unlocking packetqueue mutex]
02/05/24 14:39:49.659957 zmc_m6[16019].DB3-zm_monitor.cpp/1966 [Motion detection is enabled?(1) signal(1) signal_change(0) trigger state(Cancel) image index 5]
02/05/24 14:39:49.659977 zmc_m6[16019].DB1-zm_monitor.cpp/2196 [Not analysing 1]
02/05/24 14:39:49.660010 zmc_m6[16019].DB1-zm_monitor.cpp/2240 [!score state=IDLE]
02/05/24 14:39:49.660032 zmc_m6[16020].DB1-zm_videostore.cpp/152 [reorder_queue_size set to 300]
02/05/24 14:39:49.660085 zmc_m6[16020].DB1-zm_ffmpeg.cpp/182 [Dumping codecpar codec_type 0 video codec_id 27 h264 codec_tag 0 width 3840 height 2160 bit_rate0 bpcs 0 bprs 8 format12 yuvj420p extradata:28:0000000167420033963540780087d370101010200000000168ce31b2 profile 66 level 51 field order 1 color_range 2 color_primaries 1 color_trc 1 color_space 1 location 1 video_delay 0]
02/05/24 14:39:49.660129 zmc_m6[16019].DB1-zm_monitor.cpp/2262 [State 1 IDLE because analysis_image_count(2)-last_alarm_count(0) = 2 > post_event_count(5) and timestamp.tv_sec(1707133189) - recording.tv_src(1707133189) >= min_section_length(10)]
02/05/24 14:39:49.660166 zmc_m6[16019].DB3-zm_packetqueue.cpp/246 [stream index 0 ?= video_stream_id 0, keyframe 0, keep_keyframes 1,  counts 4 > pre_event_count 5 at begin 1]
02/05/24 14:39:49.660202 zmc_m6[16019].DB2-zm_packetqueue.cpp/560 [Incrementing 0x55f113723fe0, queue size 4, end? 0, deleting 0]
02/05/24 14:39:49.660243 zmc_m6[16019].DB2-zm_packetqueue.cpp/567 [Incrementing 0x55f113723fe0, 0x55f113723fe0 still not at end, so returning true]
02/05/24 14:39:49.660270 zmc_m6[16019].DB3-zm_packetqueue.cpp/485 [get_packet using it 0x55f113723fe0 locking index 6]
02/05/24 14:39:49.660295 zmc_m6[16019].DB2-zm_packetqueue.cpp/490 [Locked packet 6, unlocking packetqueue mutex]
02/05/24 14:39:49.660556 zmc_m6[16019].DB3-zm_monitor.cpp/1966 [Motion detection is enabled?(1) signal(1) signal_change(0) trigger state(Cancel) image index 6]
02/05/24 14:39:49.660589 zmc_m6[16019].DB1-zm_monitor.cpp/2196 [Not analysing 1]
02/05/24 14:39:49.660612 zmc_m6[16019].DB1-zm_monitor.cpp/2240 [!score state=IDLE]
02/05/24 14:39:49.660629 zmc_m6[16020].DB1-zm_ffmpeg.cpp/182 [Dumping codecpar codec_type 0 video codec_id 27 h264 codec_tag 0 width 3840 height 2160 bit_rate0 bpcs 0 bprs 8 format12 yuvj420p extradata:28:0000000167420033963540780087d370101010200000000168ce31b2 profile 66 level 51 field order 1 color_range 2 color_primaries 1 color_trc 1 color_space 1 location 1 video_delay 0]
02/05/24 14:39:49.660669 zmc_m6[16020].DB3-zm_videostore.cpp/186 [Have orientation 1]
02/05/24 14:39:49.660691 zmc_m6[16019].DB1-zm_monitor.cpp/2262 [State 1 IDLE because analysis_image_count(3)-last_alarm_count(0) = 3 > post_event_count(5) and timestamp.tv_sec(1707133189) - recording.tv_src(1707133189) >= min_section_length(10)]
02/05/24 14:39:49.660719 zmc_m6[16020].DB3-zm_ffmpeg.cpp/68 [Setting default whitelist 'file,crypto,data']
02/05/24 14:39:49.660748 zmc_m6[16019].DB3-zm_packetqueue.cpp/246 [stream index 0 ?= video_stream_id 0, keyframe 0, keep_keyframes 1,  counts 4 > pre_event_count 5 at begin 1]
02/05/24 14:39:49.660780 zmc_m6[16019].DB2-zm_packetqueue.cpp/560 [Incrementing 0x55f113723fe0, queue size 4, end? 0, deleting 0]
02/05/24 14:39:49.660805 zmc_m6[16019].DB2-zm_packetqueue.cpp/570 [At end]
02/05/24 14:39:49.660827 zmc_m6[15956].DB1-zm_db.cpp/205 [Success running sql query INSERT INTO `Logs` ( `TimeKey`, `Component`, `ServerId`, `Pid`, `Level`, `Code`, `Message`, `File`, `Line` ) VALUES ( 1707133189.658741, 'zmc_m6', 0, 16019, 0, 'INF', 'Opened new event 10645 Continuous', 'zm_monitor.cpp', 2367 ), thread_id: 2746]
02/05/24 14:39:49.660901 zmc_m6[16019].DB2-zm_packetqueue.cpp/475 [waiting.  Queue size 4 it == end? 1]
02/05/24 14:39:49.660951 zmc_m6[16020].DB1-zm_ffmpeg.cpp/246 [Dumping stream index i(0) index(0)]
02/05/24 14:39:49.660979 zmc_m6[16020].DB1-zm_ffmpeg.cpp/252 [    Stream #0:0]
02/05/24 14:39:49.661004 zmc_m6[16020].DB1-zm_ffmpeg.cpp/260 [frame_size:0 stream timebase: 1/90000]
02/05/24 14:39:49.661032 zmc_m6[16020].DB1-zm_ffmpeg.cpp/265 [codec: h264 video]
02/05/24 14:39:49.661052 zmc_m6[16020].DB1-zm_ffmpeg.cpp/283 [, SAR 0:1 ]
02/05/24 14:39:49.661073 zmc_m6[16020].DB1-zm_ffmpeg.cpp/177 [90k stream tb numerator]
02/05/24 14:39:49.661093 zmc_m6[16020].DB1-zm_videostore.cpp/552 [setting movflags to frag_keyframe+empty_moov+faststart]
02/05/24 14:39:49.661121 zmc_m6[15941].DB2-zm_ffmpeg_camera.cpp/252 [ffmpeg_camera in: pts: 266400 * 1/90000=2.960000, dts: 266400, size: 70445, stream_index: 0, video flags: 0000, keyframe(0) pos: -1, duration: 3600]
02/05/24 14:39:49.661179 zmc_m6[15941].DB2-zm_monitor.cpp/2625 [Have packet stream_index:0 ?= videostream_id: 0 q.vpktcount 4 event? 1 image_count 7]
02/05/24 14:39:49.661211 zmc_m6[15941].DB2-zm_packetqueue.cpp/142 [packet counts for 0 is 5]
02/05/24 14:39:49.661238 zmc_m6[16020].DB2-zm_ffmpeg.cpp/68 [Empty MOOV enabled; disabling automatic bitstream filtering]
02/05/24 14:39:49.661277 zmc_m6[16018].DB3-zm_packetqueue.cpp/531 [get_packet using it 0x55f11370ec80 locking index 7]
02/05/24 14:39:49.661307 zmc_m6[16018].DB2-zm_packetqueue.cpp/536 [Locked packet 7, unlocking packetqueue mutex, incrementing it]
02/05/24 14:39:49.661334 zmc_m6[16018].DB3-zm_monitor.h/739 [Last viewed 1707133189 seconds ago]
02/05/24 14:39:49.661359 zmc_m6[16018].DB1-zm_monitor.cpp/2792 [Not Decoding ? On demand]
02/05/24 14:39:49.661387 zmc_m6[16019].DB3-zm_packetqueue.cpp/485 [get_packet using it 0x55f113723fe0 locking index 7]
02/05/24 14:39:49.661425 zmc_m6[16019].DB2-zm_packetqueue.cpp/490 [Locked packet 7, unlocking packetqueue mutex]
02/05/24 14:39:49.661452 zmc_m6[16019].DB3-zm_monitor.cpp/1966 [Motion detection is enabled?(1) signal(1) signal_change(0) trigger state(Cancel) image index 7]
02/05/24 14:39:49.661480 zmc_m6[16019].DB1-zm_monitor.cpp/2196 [Not analysing 1]
02/05/24 14:39:49.661503 zmc_m6[16019].DB1-zm_monitor.cpp/2240 [!score state=IDLE]
02/05/24 14:39:49.661528 zmc_m6[16018].DB2-zm_packetqueue.cpp/521 [waiting.  Queue size 5 it == end? 1]
02/05/24 14:39:49.661564 zmc_m6[16019].DB1-zm_monitor.cpp/2262 [State 1 IDLE because analysis_image_count(4)-last_alarm_count(0) = 4 > post_event_count(5) and timestamp.tv_sec(1707133189) - recording.tv_src(1707133189) >= min_section_length(10)]
02/05/24 14:39:49.661609 zmc_m6[16019].DB3-zm_packetqueue.cpp/246 [stream index 0 ?= video_stream_id 0, keyframe 0, keep_keyframes 1,  counts 5 > pre_event_count 5 at begin 1]
02/05/24 14:39:49.661655 zmc_m6[16019].DB2-zm_packetqueue.cpp/560 [Incrementing 0x55f113723fe0, queue size 5, end? 0, deleting 0]
02/05/24 14:39:49.661712 zmc_m6[16019].DB2-zm_packetqueue.cpp/570 [At end]
02/05/24 14:39:49.661733 zmc_m6[16019].DB2-zm_packetqueue.cpp/475 [waiting.  Queue size 5 it == end? 1]
02/05/24 14:39:49.661782 zmc_m6[16020].INF-zm_videostore.cpp/570 [some options not used, turn on debugging for a list.]
02/05/24 14:39:49.661861 zmc_m6[16020].DB1-zm_videostore.cpp/573 [Encoder Option # Lines beginning with # are a comment 
# For changing quality, use the crf option
# 1 is best, 51 is worst quality
crf=>23]
02/05/24 14:39:49.661884 zmc_m6[16020].DB1-zm_videostore.cpp/573 [Encoder Option #loglevel=>verbose]
02/05/24 14:39:49.661898 zmc_m6[16020].DB1-zm_videostore.cpp/573 [Encoder Option #allowed_media_types=>video]
02/05/24 14:39:49.661913 zmc_m6[16020].DB1-zm_ffmpeg.cpp/246 [Dumping stream index i(0) index(0)]
02/05/24 14:39:49.661940 zmc_m6[16020].DB1-zm_ffmpeg.cpp/252 [    Stream #0:0]
02/05/24 14:39:49.661953 zmc_m6[16020].DB1-zm_ffmpeg.cpp/260 [frame_size:0 stream timebase: 1/90000]
02/05/24 14:39:49.661970 zmc_m6[16020].DB1-zm_ffmpeg.cpp/265 [codec: h264 video]
02/05/24 14:39:49.661990 zmc_m6[16020].DB1-zm_ffmpeg.cpp/283 [, SAR 0:1 ]
02/05/24 14:39:49.662023 zmc_m6[16020].DB1-zm_ffmpeg.cpp/177 [90k stream tb numerator]
02/05/24 14:39:49.662045 zmc_m6[16020].DB1-zm_event.cpp/669 [Video file is 10645-video.h264.mp4]
02/05/24 14:39:49.662059 zmc_m6[16020].DB1-zm_event.cpp/694 [Adding packet 3]
02/05/24 14:39:49.662086 zmc_m6[16020].DB2-zm_event.cpp/314 [have_video_keyframe 1 codec_type 0 == video? 1 packet keyframe 1]
02/05/24 14:39:49.662108 zmc_m6[16020].DB2-zm_event.cpp/316 [Adding to event: pts: 237600, dts: 237600, size: 951097, stream_index: 0, flags: 0001, keyframe(1) pos: -1, duration: 3600]
02/05/24 14:39:49.662134 zmc_m6[16020].DB1-zm_videostore.cpp/1031 [Queue size for 0 is 0]
02/05/24 14:39:49.662150 zmc_m6[16020].DB1-zm_videostore.cpp/1060 [Pushing on queue 0, size is 1]
02/05/24 14:39:49.662166 zmc_m6[16020].DB1-zm_event.cpp/402 [Have frame type Normal from score(0) state 1 frames 1 bulk frame interval 100 and mod1]
02/05/24 14:39:49.662203 zmc_m6[16020].DB1-zm_event.cpp/456 [No image]
02/05/24 14:39:49.662218 zmc_m6[16020].DB1-zm_event.cpp/473 [Frame delta is 1707133189.65 s - 1707133189.65 s = 0.00 s, score 0 zone_stats.size 0]
02/05/24 14:39:49.662236 zmc_m6[16020].DB1-zm_event.cpp/506 [Not Adding 1 frames to DB because write_to_db:0 or frames > analysis fps 0.000000 or BULK]
02/05/24 14:39:49.662250 zmc_m6[16020].DB1-zm_event.cpp/694 [Adding packet 4]
02/05/24 14:39:49.662264 zmc_m6[16020].DB2-zm_event.cpp/314 [have_video_keyframe 1 codec_type 0 == video? 1 packet keyframe 0]
02/05/24 14:39:49.662279 zmc_m6[16020].DB2-zm_event.cpp/316 [Adding to event: pts: 248400, dts: 248400, size: 56952, stream_index: 0, flags: 0000, keyframe(0) pos: -1, duration: 3600]
02/05/24 14:39:49.662291 zmc_m6[16020].DB1-zm_videostore.cpp/1031 [Queue size for 0 is 1]
02/05/24 14:39:49.662306 zmc_m6[16020].DB1-zm_videostore.cpp/1041 [Found in order packet]
02/05/24 14:39:49.662320 zmc_m6[16020].DB1-zm_videostore.cpp/1060 [Pushing on queue 0, size is 2]
02/05/24 14:39:49.662339 zmc_m6[16020].DB1-zm_event.cpp/402 [Have frame type Normal from score(0) state 1 frames 2 bulk frame interval 100 and mod2]
02/05/24 14:39:49.662354 zmc_m6[16020].DB1-zm_event.cpp/456 [No image]
02/05/24 14:39:49.662375 zmc_m6[16020].DB1-zm_event.cpp/694 [Adding packet 5]
02/05/24 14:39:49.662392 zmc_m6[16020].DB2-zm_event.cpp/314 [have_video_keyframe 1 codec_type 0 == video? 1 packet keyframe 0]
02/05/24 14:39:49.662409 zmc_m6[16020].DB2-zm_event.cpp/316 [Adding to event: pts: 252000, dts: 252000, size: 43202, stream_index: 0, flags: 0000, keyframe(0) pos: -1, duration: 3600]
02/05/24 14:39:49.662430 zmc_m6[16020].DB1-zm_videostore.cpp/1031 [Queue size for 0 is 2]
02/05/24 14:39:49.662447 zmc_m6[16020].DB1-zm_videostore.cpp/1041 [Found in order packet]
02/05/24 14:39:49.662465 zmc_m6[16020].DB1-zm_videostore.cpp/1060 [Pushing on queue 0, size is 3]
02/05/24 14:39:49.662482 zmc_m6[16020].DB1-zm_event.cpp/402 [Have frame type Normal from score(0) state 1 frames 3 bulk frame interval 100 and mod3]
@IgorA100
Copy link
Contributor Author

IgorA100 commented Feb 6, 2024

I checked the operation of the second thread (used for motion detection), and what’s most surprising is that it seems to be working despite errors in the logs:
"Failed to open secondary input"
"Could not find input codec"
"Unknown stream type"
SourceSecondPath line: rtsp://admin:admin@192.168.111.20:554/third
Detection frames are saved. But I did not study the detection in detail. I think there are problems with the timeline there too.

@IgorA100
Copy link
Contributor Author

@connortechnology
I can't understand whether the second thread is used when detecting motion or not?
It seems that analysis is taking place and events are being recorded.
But the processor load on the camera is the same when analyzing the first stream of 3840 x 2160 and when analyzing the second stream of 1280 x 720.

@connortechnology
Copy link
Member

The second path is for audio only. It is an incomplete feature.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@connortechnology @IgorA100