DVR Recording fails after short time

Live TV & DVR
1

Server Version#: 1.18.4.2171

Recording via FRITZ!BOX 6590 Cable often fails after few seconds. Here are logs from an fail yesterday at 20:15

Media Information:

  • Media Grab Device device://tv.plex.grabbers.tunerservice/dvb%23sat2ip%23uuid%3a663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9
  • Media Grab Partial Recording 1
  • Media Grab Partial Recording Reason Aufnahme wurde abgebrochen

Plex Tuner Service Log:

Jan 05, 2020 20:15:00.715 [0x7fe391d8c700] INFO - [I] SAT2IP - get_device_ip_by_device_path()
Jan 05, 2020 20:15:00.717 [0x7fe391d8c700] INFO - [I] SAT2IP - new_server_callback: found sat2ip server uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9 at 192.168.2.254
Jan 05, 2020 20:15:01.450 [0x7fe392368700] INFO - [I] web_service_t::process_start_channel (device dvb#sat2ip#3#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9, channel triplet://11111:1100:10010)
Jan 05, 2020 20:15:01.450 [0x7fe392368700] INFO - [I] sat2ip_tuner_factory_t::get_tuner_info. device uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9, frontend index 3
Jan 05, 2020 20:15:01.450 [0x7fe392368700] INFO - [I] SAT2IP - get_device_ip_by_device_path()
Jan 05, 2020 20:15:01.452 [0x7fe392368700] INFO - [I] SAT2IP - new_server_callback: found sat2ip server uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9 at 192.168.2.254
Jan 05, 2020 20:15:01.459 [0x7fe392368700] INFO - [I] web_service_t::process_start_channel. Trying start channel triplet://11111:1100:10010 on device dvb#sat2ip#3#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9 (idx 0 out of 1 available)
Jan 05, 2020 20:15:01.460 [0x7fe392368700] INFO - [I] device_manager_t::add_streamer. Channel triplet://11111:1100:10010, device dvb#sat2ip#3#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9, streamer id 7bcc8001-4d3e-4e80-8f34-80a434e502d1 
Jan 05, 2020 20:15:01.460 [0x7fe392368700] INFO - [I] device_reactor_t::create_device dvb#sat2ip#3#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9
Jan 05, 2020 20:15:01.460 [0x7fe392368700] INFO - [I] device_manager_t::add_streamer. Adding new streamer container for channel triplet://11111:1100:10010 on device device dvb#sat2ip#3#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9.
Jan 05, 2020 20:15:01.464 [0x7fe392368700] INFO - [I] transponder_streamer::start_idle_timer
Jan 05, 2020 20:15:01.467 [0x7fe392368700] INFO - [I] tvs_program_streamer::tvs_program_streamer. Select program for nid 11111, tid 1100, sid 10010
Jan 05, 2020 20:15:01.470 [0x7fe36b447700] INFO - [I] streamer_container_t::control_thread. Added streamer 7bcc8001-4d3e-4e80-8f34-80a434e502d1
Jan 05, 2020 20:15:01.470 [0x7fe3917b0700] INFO - [I] web_service_t::process_start_channel (device dvb#sat2ip#1#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9, channel triplet://11111:1009:1030)
Jan 05, 2020 20:15:01.470 [0x7fe36b447700] INFO - [I] streamer_container_t::control_thread. First streamer was added. Start program streamer
Jan 05, 2020 20:15:01.470 [0x7fe36b447700] INFO - [I] dvb_program_streamer_t::start. Starting program streamer for channel triplet://11111:1100:10010
Jan 05, 2020 20:15:01.470 [0x7fe36b447700] INFO - [I] transponder_streamer::start_channel. Start request for channel triplet://11111:1100:10010
Jan 05, 2020 20:15:01.470 [0x7fe36b447700] INFO - [I] transponder_streamer::stop_idle_timer
Jan 05, 2020 20:15:01.519 [0x7fe36ae6b700] INFO - [I] SAT2IP. Start device uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9, frontend index 3
Jan 05, 2020 20:15:01.519 [0x7fe36ae6b700] INFO - [I] SAT2IP - get_device_ip_by_device_path()
Jan 05, 2020 20:15:01.521 [0x7fe36ae6b700] INFO - [I] SAT2IP - new_server_callback: found sat2ip server uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9 at 192.168.2.254
Jan 05, 2020 20:15:01.522 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::TuneTransponder. Transponder tuning request: diseqc 0, freq 466000, modulation 0, polarization 0, symbol rate 6900000, LOF 7, LNB selection signal 0, FEC 0
Jan 05, 2020 20:15:01.522 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::prepare_rtp_session. Searching for free ports starting from base 23758
Jan 05, 2020 20:15:01.524 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::prepare_rtp_session. Found two free ports 23758 and 23759
Jan 05, 2020 20:15:01.524 [0x7fe36ae6b700] INFO - [I] get_sat2ip_tuning_string. Resulting string freq=466.00&msys=dvbc&mtype=256qam&sr=6900
Jan 05, 2020 20:15:01.524 [0x7fe36ae6b700] DEBUG - [I] sat2ip_streamer::sat2ip_send_command. Request: SETUP rtsp://192.168.2.254/?src=1&fe=4&freq=466.00&msys=dvbc&mtype=256qam&sr=6900&pids=0,21 RTSP/1.0
Transport: RTP/AVP;unicast;client_port=23758-23759
CSeq: 1

Jan 05, 2020 20:15:01.526 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::send_prepare_command. Succeeded. New stream ID is 464
Jan 05, 2020 20:15:01.526 [0x7fe36ae6b700] DEBUG - [I] sat2ip_streamer::sat2ip_send_command. Request: PLAY rtsp://192.168.2.254/stream=464?pids=0,21 RTSP/1.0
CSeq: 2
Session: 464

Jan 05, 2020 20:15:02.973 [0x7fe36a2b3700] INFO - [I] sat2ip_streamer::reception_thread_func. Reception thread is started
Jan 05, 2020 20:15:02.973 [0x7fe36ae6b700] DEBUG - [I] sat2ip_streamer::start_reception. Trying to raise reception thread priority to 74
Jan 05, 2020 20:15:02.973 [0x7fe39032e700] INFO - [I] sat2ip_streamer::control_thread_func. Control thread is started
Jan 05, 2020 20:15:02.973 [0x7fe36ae6b700] WARN - [W] sat2ip_streamer::start_reception. pthread_setschedparam failed 1
Jan 05, 2020 20:15:03.024 [0x7fe39032e700] DEBUG - [I] sat2ip_streamer::sat2ip_send_command. Request: DESCRIBE rtsp://192.168.2.254/stream=464 RTSP/1.0
Accept: application/sdp
CSeq: 3
Session: 464

Jan 05, 2020 20:15:03.025 [0x7fe36b447700] INFO - [I] transponder_streamer::tune_transponder_impl. Signal stats: 62, 0, 1
Jan 05, 2020 20:15:03.026 [0x7fe392368700] INFO - [I] web_service_t::process_start_channel. Successfully started channel triplet://11111:1100:10010 on device dvb#sat2ip#3#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9 
Jan 05, 2020 20:15:03.026 [0x7fe3917b0700] INFO - [I] sat2ip_tuner_factory_t::get_tuner_info. device uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9, frontend index 1
Jan 05, 2020 20:15:03.026 [0x7fe3917b0700] INFO - [I] SAT2IP - get_device_ip_by_device_path()
Jan 05, 2020 20:15:03.026 [0x7fe36b735700] INFO - [I] tvs_program_streamer::tuning_thread. Starting tuning thread for program triplet://11111:1100:10010
Jan 05, 2020 20:15:03.026 [0x7fe36b735700] INFO - [I] tvs_program_streamer::SetPATScanState. Waiting for PAT...
Jan 05, 2020 20:15:03.028 [0x7fe3917b0700] INFO - [I] SAT2IP - new_server_callback: found sat2ip server uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9 at 192.168.2.254
Jan 05, 2020 20:15:03.029 [0x7fe36a5a1700] INFO - [I] http_streamer_t::send_thread_func: adding http client
Jan 05, 2020 20:15:03.036 [0x7fe3917b0700] INFO - [I] web_service_t::process_start_channel. Trying start channel triplet://11111:1009:1030 on device dvb#sat2ip#1#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9 (idx 0 out of 1 available)
Jan 05, 2020 20:15:03.036 [0x7fe3917b0700] INFO - [I] device_manager_t::add_streamer. Channel triplet://11111:1009:1030, device dvb#sat2ip#1#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9, streamer id 9166b12a-794c-4566-807e-418888469687 
Jan 05, 2020 20:15:03.036 [0x7fe3917b0700] INFO - [I] device_reactor_t::create_device dvb#sat2ip#1#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9
Jan 05, 2020 20:15:03.036 [0x7fe3917b0700] INFO - [I] device_manager_t::add_streamer. Adding new streamer container for channel triplet://11111:1009:1030 on device device dvb#sat2ip#1#uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9.
Jan 05, 2020 20:15:03.039 [0x7fe3917b0700] INFO - [I] transponder_streamer::start_idle_timer
Jan 05, 2020 20:15:03.040 [0x7fe3917b0700] INFO - [I] tvs_program_streamer::tvs_program_streamer. Select program for nid 11111, tid 1009, sid 1030
Jan 05, 2020 20:15:03.040 [0x7fe36ba23700] INFO - [I] streamer_container_t::control_thread. Added streamer 9166b12a-794c-4566-807e-418888469687
Jan 05, 2020 20:15:03.040 [0x7fe36ba23700] INFO - [I] streamer_container_t::control_thread. First streamer was added. Start program streamer
Jan 05, 2020 20:15:03.040 [0x7fe36ba23700] INFO - [I] dvb_program_streamer_t::start. Starting program streamer for channel triplet://11111:1009:1030
Jan 05, 2020 20:15:03.040 [0x7fe36ba23700] INFO - [I] transponder_streamer::start_channel. Start request for channel triplet://11111:1009:1030
Jan 05, 2020 20:15:03.040 [0x7fe36ba23700] INFO - [I] transponder_streamer::stop_idle_timer
Jan 05, 2020 20:15:03.076 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 0, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.076 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 0
Jan 05, 2020 20:15:03.090 [0x7fe36bd11700] INFO - [I] SAT2IP. Start device uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9, frontend index 1
Jan 05, 2020 20:15:03.090 [0x7fe36bd11700] INFO - [I] SAT2IP - get_device_ip_by_device_path()
Jan 05, 2020 20:15:03.091 [0x7fe36bd11700] INFO - [I] SAT2IP - new_server_callback: found sat2ip server uuid:663d5d6c-f9f8-4bb4-84d4-444E6D4FFCD9 at 192.168.2.254
Jan 05, 2020 20:15:03.091 [0x7fe36bd11700] INFO - [I] CTVSStreamSource::TuneTransponder. Transponder tuning request: diseqc 0, freq 346000, modulation 0, polarization 0, symbol rate 6900000, LOF 7, LNB selection signal 0, FEC 0
Jan 05, 2020 20:15:03.092 [0x7fe36bd11700] INFO - [I] sat2ip_streamer::prepare_rtp_session. Searching for free ports starting from base 28982
Jan 05, 2020 20:15:03.094 [0x7fe36bd11700] INFO - [I] sat2ip_streamer::prepare_rtp_session. Found two free ports 28982 and 28983
Jan 05, 2020 20:15:03.094 [0x7fe36bd11700] INFO - [I] get_sat2ip_tuning_string. Resulting string freq=346.00&msys=dvbc&mtype=256qam&sr=6900
Jan 05, 2020 20:15:03.094 [0x7fe36bd11700] DEBUG - [I] sat2ip_streamer::sat2ip_send_command. Request: SETUP rtsp://192.168.2.254/?src=1&fe=2&freq=346.00&msys=dvbc&mtype=256qam&sr=6900&pids=0,21 RTSP/1.0
Transport: RTP/AVP;unicast;client_port=28982-28983
CSeq: 1

Jan 05, 2020 20:15:03.097 [0x7fe36bd11700] INFO - [I] sat2ip_streamer::send_prepare_command. Succeeded. New stream ID is 465
Jan 05, 2020 20:15:03.097 [0x7fe36bd11700] DEBUG - [I] sat2ip_streamer::sat2ip_send_command. Request: PLAY rtsp://192.168.2.254/stream=465?pids=0,21 RTSP/1.0
CSeq: 2
Session: 465

Jan 05, 2020 20:15:03.126 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 1, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.126 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 1
Jan 05, 2020 20:15:03.126 [0x7fe39032e700] DEBUG - [I] sat2ip_streamer::sat2ip_send_command. Request: PLAY rtsp://192.168.2.254/stream=464?pids=0,1,21 RTSP/1.0
CSeq: 4
Session: 464

Jan 05, 2020 20:15:03.329 [0x7fe36ae6b700] DEBUG - [I] required sid 10010
Jan 05, 2020 20:15:03.329 [0x7fe36ae6b700] DEBUG - [I] services (25): 10010, 
Jan 05, 2020 20:15:03.329 [0x7fe36ae6b700] DEBUG - [I] pmt pid found: 256
Jan 05, 2020 20:15:03.376 [0x7fe36b735700] INFO - [I] tvs_program_streamer::tuning_thread. Waiting for PMT...
Jan 05, 2020 20:15:03.379 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 256, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.380 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 256
Jan 05, 2020 20:15:03.382 [0x7fe39032e700] DEBUG - [I] sat2ip_streamer::sat2ip_send_command. Request: PLAY rtsp://192.168.2.254/stream=464?pids=0,1,21,256 RTSP/1.0
CSeq: 5
Session: 464

Jan 05, 2020 20:15:03.580 [0x7fe36b735700] INFO - [I] tvs_program_streamer::tuning_thread. PAT and PMT found. Checking CA descriptors
Jan 05, 2020 20:15:03.630 [0x7fe36b735700] INFO - [I] tvs_program_streamer::tuning_thread. Start streaming
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 257, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 257
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 258, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 258
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 259, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 259
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 260, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 260
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 261, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 261
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 262, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 262
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 263, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 263
Jan 05, 2020 20:15:03.632 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 264, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 264
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 265, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 265
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 257, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 0, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 1, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 16, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 16
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 17, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 17
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 18, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] sat2ip_streamer::add_pid. Adding pid 18
Jan 05, 2020 20:15:03.633 [0x7fe36ae6b700] INFO - [I] CTVSStreamSource::AddPID. Requesting PID 8191, client triplet://11111:1100:10010
Jan 05, 2020 20:15:03.636 [0x7fe39032e700] DEBUG - [I] sat2ip_streamer::sat2ip_send_command. Request: PLAY rtsp://192.168.2.254/stream=464?pids=0,1,16,17,18,21,256,257,258,259,260,261,262,263,264,265 RTSP/1.0
CSeq: 6
Session: 464

Jan 05, 2020 20:15:03.683 [0x7fe36b735700] INFO - [I] tvs_program_streamer::tuning_thread. Finished tuning thread for program triplet://11111:1100:10010
Jan 05, 2020 20:15:03.724 [0x7fe391d8c700] INFO - [I] web_service_t::process_device_status
Jan 05, 2020 20:15:03.858 [0x7fe36bd11700] DEBUG - [I] sat2ip_streamer::start_reception. Trying to raise reception thread priority to 74
Jan 05, 2020 20:15:03.858 [0x7fe36bd11700] WARN - [W] sat2ip_streamer::start_reception. pthread_setschedparam failed 1
Jan 05, 2020 20:15:03.858 [0x7fe36bfff700] INFO - [I] sat2ip_streamer::control_thread_func. Control thread is started
Jan 05, 2020 20:15:03.858 [0x7fe39090a700] INFO - [I] sat2ip_streamer::reception_thread_func. Reception thread is started
Jan 05, 2020 20:15:03.908 [0x7fe36bfff700] DEBUG - [I] sat2ip_streamer::sat2ip_send_command. Request: DESCRIBE rtsp://192.168.2.254/stream=465 RTSP/1.0
Accept: application/sdp
CSeq: 3
Session: 465
2

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.