Web stream ends after 5 min

web stream ends after 5 min. At first I thought that the problem was in the stream or icecast, but from the logs I see that [pypofetch] [INFO] Queue timeout. Fetching schedule manually. I’m new to this, help maybe misconfigured LibreTime.

Blockquote

2021-11-10 09:06:40,379 [__main__] [INFO ]  ###########################################
2021-11-10 09:06:40,460 [__main__] [INFO ]  #             *** pypo  ***               #
2021-11-10 09:06:40,460 [__main__] [INFO ]  #   Liquidsoap Scheduled Playout System   #
2021-11-10 09:06:40,461 [__main__] [INFO ]  ###########################################
2021-11-10 09:06:40,461 [__main__] [INFO ]  Timezone: ('MSK', 'MSK')
2021-11-10 09:06:40,461 [__main__] [INFO ]  UTC time: 2021-11-10 06:06:40.461371
2021-11-10 09:06:55,570 [version1] [INFO ]  Airtime API version found: 1.1
2021-11-10 09:06:55,571 [version1] [INFO ]  pypo is only compatible with API version: 1.1
2021-11-10 09:06:55,968 [__main__] [ERROR]  [Errno 111] Connection refused
2021-11-10 09:06:55,968 [__main__] [WARNI]  Liquidsoap doesn't appear to be running!, Sleeping and trying again
2021-11-10 09:06:56,970 [__main__] [ERROR]  [Errno 111] Connection refused
2021-11-10 09:06:56,971 [__main__] [WARNI]  Liquidsoap doesn't appear to be running!, Sleeping and trying again
2021-11-10 09:06:57,980 [__main__] [INFO ]  Liquidsoap version string found 1.1.1
2021-11-10 09:06:57,981 [pypomessagehandler] [INFO ]  Initializing RabbitMQ stuff
2021-11-10 09:06:58,060 [mixins] [WARNI]  Broker connection error, trying again in 2.0 seconds: ConnectionRefusedError(111, 'Connection refused').
Traceback (most recent call last):
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 138, in _connect
    host, port, family, socket.SOCK_STREAM, SOL_TCP)
  File "/usr/lib/python3.6/socket.py", line 745, in getaddrinfo
    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
socket.gaierror: [Errno -9] Address family for hostname not supported

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.6/dist-packages/kombu/utils/functional.py", line 344, in retry_over_time
    return fun(*args, **kwargs)
  File "/usr/local/lib/python3.6/dist-packages/kombu/connection.py", line 870, in _connection_factory
    connection = self._establish_connection()
  File "/usr/local/lib/python3.6/dist-packages/kombu/connection.py", line 806, in _establish_connection
    conn = self.transport.establish_connection()
  File "/usr/local/lib/python3.6/dist-packages/kombu/transport/pyamqp.py", line 130, in establish_connection
    conn.connect()
  File "/usr/local/lib/python3.6/dist-packages/amqp/connection.py", line 314, in connect
    self.transport.connect()
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 78, in connect
    self._connect(self.host, self.port, self.connect_timeout)
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 149, in _connect
    "failed to resolve broker hostname"))
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 162, in _connect
    self.sock.connect(sa)
ConnectionRefusedError: [Errno 111] Connection refused
2021-11-10 09:06:58,071 [pypofetch] [INFO ]  PypoFetch: init complete
2021-11-10 09:07:01,990 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 09:07:02,003 [recorder] [INFO ]  RecorderFetch: init complete
2021-11-10 09:07:02,198 [recorder] [INFO ]  Started...
2021-11-10 09:07:02,278 [telnetliquidsoap] [INFO ]  streams.live_dj_stop

2021-11-10 09:07:02,278 [telnetliquidsoap] [INFO ]  streams.master_dj_stop

2021-11-10 09:07:02,278 [telnetliquidsoap] [INFO ]  streams.scheduled_play_start

2021-11-10 09:07:02,278 [telnetliquidsoap] [INFO ]  b'vars.stream_metadata_type 0\n'
2021-11-10 09:07:02,279 [telnetliquidsoap] [INFO ]  b'vars.station_name \n'
2021-11-10 09:07:02,281 [telnetliquidsoap] [INFO ]  b'vars.default_dj_fade 0.000\n'
2021-11-10 09:07:02,368 [recorder] [INFO ]  Parsing recording show schedules...
2021-11-10 09:07:02,368 [recorder] [INFO ]  Bootstrap recorder schedule received: {'shows': [], 'is_recording': False, 'server_timezone': 'Europe/Moscow'}
2021-11-10 09:07:02,368 [recorder] [INFO ]  Bootstrap complete: got initial copy of the schedule
2021-11-10 09:07:04,021 [mixins] [WARNI]  Broker connection error, trying again in 4.0 seconds: ConnectionRefusedError(111, 'Connection refused').
Traceback (most recent call last):
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 138, in _connect
    host, port, family, socket.SOCK_STREAM, SOL_TCP)
  File "/usr/lib/python3.6/socket.py", line 745, in getaddrinfo
    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
socket.gaierror: [Errno -9] Address family for hostname not supported

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.6/dist-packages/kombu/utils/functional.py", line 344, in retry_over_time
    return fun(*args, **kwargs)
  File "/usr/local/lib/python3.6/dist-packages/kombu/connection.py", line 870, in _connection_factory
    connection = self._establish_connection()
  File "/usr/local/lib/python3.6/dist-packages/kombu/connection.py", line 806, in _establish_connection
    conn = self.transport.establish_connection()
  File "/usr/local/lib/python3.6/dist-packages/kombu/transport/pyamqp.py", line 130, in establish_connection
    conn.connect()
  File "/usr/local/lib/python3.6/dist-packages/amqp/connection.py", line 314, in connect
    self.transport.connect()
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 78, in connect
    self._connect(self.host, self.port, self.connect_timeout)
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 149, in _connect
    "failed to resolve broker hostname"))
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 162, in _connect
    self.sock.connect(sa)
ConnectionRefusedError: [Errno 111] Connection refused
2021-11-10 09:07:08,053 [mixins] [WARNI]  Broker connection error, trying again in 6.0 seconds: ConnectionRefusedError(111, 'Connection refused').
Traceback (most recent call last):
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 138, in _connect
    host, port, family, socket.SOCK_STREAM, SOL_TCP)
  File "/usr/lib/python3.6/socket.py", line 745, in getaddrinfo
    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
socket.gaierror: [Errno -9] Address family for hostname not supported

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.6/dist-packages/kombu/utils/functional.py", line 344, in retry_over_time
    return fun(*args, **kwargs)
  File "/usr/local/lib/python3.6/dist-packages/kombu/connection.py", line 870, in _connection_factory
    connection = self._establish_connection()
  File "/usr/local/lib/python3.6/dist-packages/kombu/connection.py", line 806, in _establish_connection
    conn = self.transport.establish_connection()
  File "/usr/local/lib/python3.6/dist-packages/kombu/transport/pyamqp.py", line 130, in establish_connection
    conn.connect()
  File "/usr/local/lib/python3.6/dist-packages/amqp/connection.py", line 314, in connect
    self.transport.connect()
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 78, in connect
    self._connect(self.host, self.port, self.connect_timeout)
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 149, in _connect
    "failed to resolve broker hostname"))
  File "/usr/local/lib/python3.6/dist-packages/amqp/transport.py", line 162, in _connect
    self.sock.connect(sa)
ConnectionRefusedError: [Errno 111] Connection refused
2021-11-10 09:07:13,023 [utils] [ERROR]  GET http://10.252.0.155:80/api/v2/shows/3/ request failed '502':
Payload: None
Response: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
<html><head>
<title>502 Proxy Error</title>
</head><body>
<h1>Proxy Error</h1>
<p>The proxy server received an invalid
response from an upstream server.<br />
The proxy server could not handle the request<p>Reason: <strong>Error reading from remote server</strong></p></p>
<hr>
<address>Apache/2.4.29 (Ubuntu) Server at 10.252.0.155 Port 80</address>
</body></html>

2021-11-10 09:07:13,023 [pypofetch] [ERROR]  Unable to fetch schedule
2021-11-10 09:07:13,023 [pypofetch] [ERROR]  502 Server Error: Proxy Error for url: http://10.252.0.155:80/api/v2/shows/3/
Traceback (most recent call last):
  File "/usr/local/lib/python3.6/dist-packages/pypo/pypofetch.py", line 460, in manual_schedule_fetch
    self.schedule_data = self.api_client.get_schedule()
  File "/usr/local/lib/python3.6/dist-packages/api_clients/version2.py", line 68, in get_schedule
    show = self.services.show_url(id=show_instance["show_id"])
  File "/usr/local/lib/python3.6/dist-packages/api_clients/utils.py", line 122, in __call__
    res.raise_for_status()
  File "/usr/lib/python3/dist-packages/requests/models.py", line 935, in raise_for_status
    raise HTTPError(http_error_msg, response=self)
requests.exceptions.HTTPError: 502 Server Error: Proxy Error for url: http://10.252.0.155:80/api/v2/shows/3/
2021-11-10 09:07:14,099 [mixins] [INFO ]  Connected to amqp://airtime:**@127.0.0.1:5672//airtime
2021-11-10 09:07:18,453 [pypopush] [INFO ]  heartbeat
2021-11-10 09:07:18,453 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 09:07:18,454 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 09:07:18,460 [pypofetch] [INFO ]  Bootstrap schedule received: {'media': {'2021-11-10-05-00-00': {'start': datetime.datetime(2021, 11, 10, 5, 0), 'end': datetime.datetime(2021, 11, 10, 5, 0), 'row_id': 48, 'show_name': 'RDV-CEN', 'independent_event': True, 'id': 1, 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_buffer_start'}}, '2021-11-10-05-00-00_0': {'id': 1, 'type': 'stream_output_start', 'start': '2021-11-10-05-00-00', 'end': '2021-11-10-05-00-00', 'uri': 'http://c18.radioboss.fm:8293/stream', 'row_id': 48, 'independent_event': True}, '2021-11-10T19:00:00+00:00': {'type': 'stream_buffer_end', 'start': '2021-11-10-05-00-00', 'end': '2021-11-10-05-00-00', 'uri': 'http://c18.radioboss.fm:8293/stream', 'row_id': 48, 'independent_event': True}, '2021-11-10T19:00:00+00:00_0': {'type': 'stream_output_end', 'start': '2021-11-10-05-00-00', 'end': '2021-11-10-05-00-00', 'uri': 'http://c18.radioboss.fm:8293/stream', 'row_id': 48, 'independent_event': True}}
2021-11-10 09:07:18,461 [pypofetch] [INFO ]  Loop #1
2021-11-10 09:08:56,944 [pypomessagehandler] [INFO ]  Received event from RabbitMQ: {"event_type":"reset_liquidsoap_bootstrap"}
2021-11-10 09:08:56,955 [pypomessagehandler] [INFO ]  Handling command: reset_liquidsoap_bootstrap
2021-11-10 09:08:56,956 [pypomessagehandler] [INFO ]  Resetting bootstrap vars...
2021-11-10 09:08:56,957 [pypofetch] [INFO ]  Received event from Pypo Message Handler: {"event_type":"reset_liquidsoap_bootstrap"}
2021-11-10 09:08:56,957 [pypofetch] [INFO ]  Handling command: reset_liquidsoap_bootstrap
2021-11-10 09:08:56,995 [pypomessagehandler] [INFO ]  Received event from RabbitMQ: {"schedule":{"media":{"2021-11-10-05-00-00":{"start":"2021-11-10-04-59-55","end":"2021-11-10-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":48,"type":"stream_buffer_start","independent_event":true},"2021-11-10-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":48,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-10-05-00-00","end":"2021-11-10-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-10-18-59-59":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":48,"independent_event":true},"2021-11-10-18-59-59_0":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true},"2021-11-11-05-00-00":{"start":"2021-11-11-04-59-55","end":"2021-11-11-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":53,"type":"stream_buffer_start","independent_event":true},"2021-11-11-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":53,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-11-05-00-00","end":"2021-11-11-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-11-18-59-59":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":53,"independent_event":true},"2021-11-11-18-59-59_0":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true}}},"event_type":"update_schedule"}
2021-11-10 09:08:56,995 [pypomessagehandler] [INFO ]  Handling command: update_schedule
2021-11-10 09:08:56,995 [pypomessagehandler] [INFO ]  Updating schedule...
2021-11-10 09:08:57,059 [telnetliquidsoap] [INFO ]  streams.live_dj_stop

2021-11-10 09:08:57,060 [telnetliquidsoap] [INFO ]  streams.master_dj_stop

2021-11-10 09:08:57,060 [telnetliquidsoap] [INFO ]  streams.scheduled_play_start

2021-11-10 09:08:57,061 [telnetliquidsoap] [INFO ]  b'vars.stream_metadata_type 0\n'
2021-11-10 09:08:57,061 [telnetliquidsoap] [INFO ]  b'vars.station_name \n'
2021-11-10 09:08:57,061 [telnetliquidsoap] [INFO ]  b'vars.default_dj_fade 0.000\n'
2021-11-10 09:08:57,106 [pypofetch] [INFO ]  New timeout: 301.29976415634155
2021-11-10 09:08:57,106 [pypofetch] [INFO ]  Loop #2
2021-11-10 09:08:57,106 [pypofetch] [INFO ]  Received event from Pypo Message Handler: {"schedule":{"media":{"2021-11-10-05-00-00":{"start":"2021-11-10-04-59-55","end":"2021-11-10-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":48,"type":"stream_buffer_start","independent_event":true},"2021-11-10-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":48,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-10-05-00-00","end":"2021-11-10-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-10-18-59-59":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":48,"independent_event":true},"2021-11-10-18-59-59_0":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true},"2021-11-11-05-00-00":{"start":"2021-11-11-04-59-55","end":"2021-11-11-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":53,"type":"stream_buffer_start","independent_event":true},"2021-11-11-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":53,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-11-05-00-00","end":"2021-11-11-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-11-18-59-59":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":53,"independent_event":true},"2021-11-11-18-59-59_0":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true}}},"event_type":"update_schedule"}
2021-11-10 09:08:57,106 [pypofetch] [INFO ]  Handling command: update_schedule
2021-11-10 09:08:57,108 [pypofetch] [INFO ]  New timeout: 400
2021-11-10 09:08:57,109 [pypofetch] [INFO ]  Loop #3
2021-11-10 09:08:57,712 [pypoliqqueue] [INFO ]  New schedule received: {'2021-11-10-18-59-59': {'start': datetime.datetime(2021, 11, 10, 18, 59, 59), 'end': datetime.datetime(2021, 11, 10, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_buffer_end', 'row_id': 48, 'independent_event': True}, '2021-11-10-18-59-59_0': {'start': datetime.datetime(2021, 11, 10, 18, 59, 59), 'end': datetime.datetime(2021, 11, 10, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_output_end', 'independent_event': True}, '2021-11-11-05-00-00': {'start': datetime.datetime(2021, 11, 11, 4, 59, 55), 'end': datetime.datetime(2021, 11, 11, 4, 59, 55), 'uri': 'http://c18.radioboss.fm:8293/stream', 'row_id': 53, 'type': 'stream_buffer_start', 'independent_event': True}, '2021-11-11-05-00-00_0': {'id': 1, 'type': 'stream_output_start', 'row_id': 53, 'uri': 'http://c18.radioboss.fm:8293/stream', 'start': datetime.datetime(2021, 11, 11, 5, 0), 'end': datetime.datetime(2021, 11, 11, 19, 0), 'show_name': 'RDV-CEN', 'independent_event': True}, '2021-11-11-18-59-59': {'start': datetime.datetime(2021, 11, 11, 18, 59, 59), 'end': datetime.datetime(2021, 11, 11, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_buffer_end', 'row_id': 53, 'independent_event': True}, '2021-11-11-18-59-59_0': {'start': datetime.datetime(2021, 11, 11, 18, 59, 59), 'end': datetime.datetime(2021, 11, 11, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_output_end', 'independent_event': True}}
2021-11-10 09:08:57,713 [pypoliqqueue] [INFO ]  waiting 46261.286515s until next scheduled item
2021-11-10 09:12:23,232 [pypomessagehandler] [INFO ]  Received event from RabbitMQ: {"schedule":{"media":{"2021-11-10-05-00-00":{"start":"2021-11-10-04-59-55","end":"2021-11-10-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":48,"type":"stream_buffer_start","independent_event":true},"2021-11-10-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":48,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-10-05-00-00","end":"2021-11-10-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-10-18-59-59":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":48,"independent_event":true},"2021-11-10-18-59-59_0":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true},"2021-11-11-05-00-00":{"start":"2021-11-11-04-59-55","end":"2021-11-11-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":53,"type":"stream_buffer_start","independent_event":true},"2021-11-11-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":53,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-11-05-00-00","end":"2021-11-11-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-11-18-59-59":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":53,"independent_event":true},"2021-11-11-18-59-59_0":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true}}},"event_type":"update_schedule"}
2021-11-10 09:12:23,233 [pypomessagehandler] [INFO ]  Handling command: update_schedule
2021-11-10 09:12:23,233 [pypomessagehandler] [INFO ]  Updating schedule...
2021-11-10 09:12:23,234 [pypofetch] [INFO ]  Received event from Pypo Message Handler: {"schedule":{"media":{"2021-11-10-05-00-00":{"start":"2021-11-10-04-59-55","end":"2021-11-10-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":48,"type":"stream_buffer_start","independent_event":true},"2021-11-10-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":48,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-10-05-00-00","end":"2021-11-10-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-10-18-59-59":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":48,"independent_event":true},"2021-11-10-18-59-59_0":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true},"2021-11-11-05-00-00":{"start":"2021-11-11-04-59-55","end":"2021-11-11-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":53,"type":"stream_buffer_start","independent_event":true},"2021-11-11-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":53,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-11-05-00-00","end":"2021-11-11-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-11-18-59-59":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":53,"independent_event":true},"2021-11-11-18-59-59_0":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true}}},"event_type":"update_schedule"}
2021-11-10 09:12:23,234 [pypofetch] [INFO ]  Handling command: update_schedule
2021-11-10 09:12:23,237 [pypoliqqueue] [INFO ]  New schedule received: {'2021-11-10-18-59-59': {'start': datetime.datetime(2021, 11, 10, 18, 59, 59), 'end': datetime.datetime(2021, 11, 10, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_buffer_end', 'row_id': 48, 'independent_event': True}, '2021-11-10-18-59-59_0': {'start': datetime.datetime(2021, 11, 10, 18, 59, 59), 'end': datetime.datetime(2021, 11, 10, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_output_end', 'independent_event': True}, '2021-11-11-05-00-00': {'start': datetime.datetime(2021, 11, 11, 4, 59, 55), 'end': datetime.datetime(2021, 11, 11, 4, 59, 55), 'uri': 'http://c18.radioboss.fm:8293/stream', 'row_id': 53, 'type': 'stream_buffer_start', 'independent_event': True}, '2021-11-11-05-00-00_0': {'id': 1, 'type': 'stream_output_start', 'row_id': 53, 'uri': 'http://c18.radioboss.fm:8293/stream', 'start': datetime.datetime(2021, 11, 11, 5, 0), 'end': datetime.datetime(2021, 11, 11, 19, 0), 'show_name': 'RDV-CEN', 'independent_event': True}, '2021-11-11-18-59-59': {'start': datetime.datetime(2021, 11, 11, 18, 59, 59), 'end': datetime.datetime(2021, 11, 11, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_buffer_end', 'row_id': 53, 'independent_event': True}, '2021-11-11-18-59-59_0': {'start': datetime.datetime(2021, 11, 11, 18, 59, 59), 'end': datetime.datetime(2021, 11, 11, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_output_end', 'independent_event': True}}
2021-11-10 09:12:23,238 [pypoliqqueue] [INFO ]  waiting 46055.76197s until next scheduled item
2021-11-10 09:12:23,248 [pypofetch] [INFO ]  New timeout: 400
2021-11-10 09:12:23,248 [pypofetch] [INFO ]  Loop #4
2021-11-10 09:19:03,249 [pypofetch] [INFO ]  Queue timeout. Fetching schedule manually
2021-11-10 09:19:07,799 [pypofetch] [INFO ]  Loop #5
2021-11-10 09:19:07,806 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 09:19:07,806 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 09:25:47,806 [pypofetch] [INFO ]  Queue timeout. Fetching schedule manually
2021-11-10 09:25:47,951 [pypofetch] [INFO ]  Loop #6
2021-11-10 09:25:47,956 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 09:25:47,956 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 09:32:27,954 [pypofetch] [INFO ]  Queue timeout. Fetching schedule manually
2021-11-10 09:32:30,769 [pypofetch] [INFO ]  Loop #7
2021-11-10 09:32:30,775 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 09:32:30,776 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 09:39:10,770 [pypofetch] [INFO ]  Queue timeout. Fetching schedule manually
2021-11-10 09:39:10,902 [pypofetch] [INFO ]  Loop #8
2021-11-10 09:39:10,905 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 09:39:10,905 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 09:45:52,187 [pypofetch] [INFO ]  Queue timeout. Fetching schedule manually
2021-11-10 09:46:26,782 [pypofetch] [INFO ]  Loop #9
2021-11-10 09:46:28,474 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 09:46:28,491 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 09:53:06,835 [pypofetch] [INFO ]  Queue timeout. Fetching schedule manually
2021-11-10 09:53:12,547 [pypofetch] [INFO ]  Loop #10
2021-11-10 09:53:12,575 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 09:53:12,576 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 09:59:52,547 [pypofetch] [INFO ]  Queue timeout. Fetching schedule manually
2021-11-10 09:59:52,920 [pypofetch] [INFO ]  Loop #11
2021-11-10 09:59:52,923 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 09:59:52,923 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 10:00:51,378 [pypomessagehandler] [INFO ]  Received event from RabbitMQ: {"schedule":{"media":{"2021-11-10-05-00-00":{"start":"2021-11-10-04-59-55","end":"2021-11-10-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":48,"type":"stream_buffer_start","independent_event":true},"2021-11-10-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":48,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-10-05-00-00","end":"2021-11-10-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-10-18-59-59":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":48,"independent_event":true},"2021-11-10-18-59-59_0":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true},"2021-11-11-05-00-00":{"start":"2021-11-11-04-59-55","end":"2021-11-11-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":53,"type":"stream_buffer_start","independent_event":true},"2021-11-11-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":53,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-11-05-00-00","end":"2021-11-11-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-11-18-59-59":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":53,"independent_event":true},"2021-11-11-18-59-59_0":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true}}},"event_type":"update_schedule"}
2021-11-10 10:00:51,380 [pypomessagehandler] [INFO ]  Handling command: update_schedule
2021-11-10 10:00:51,380 [pypomessagehandler] [INFO ]  Updating schedule...
2021-11-10 10:00:51,398 [pypofetch] [INFO ]  Received event from Pypo Message Handler: {"schedule":{"media":{"2021-11-10-05-00-00":{"start":"2021-11-10-04-59-55","end":"2021-11-10-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":48,"type":"stream_buffer_start","independent_event":true},"2021-11-10-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":48,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-10-05-00-00","end":"2021-11-10-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-10-18-59-59":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":48,"independent_event":true},"2021-11-10-18-59-59_0":{"start":"2021-11-10-18-59-59","end":"2021-11-10-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true},"2021-11-11-05-00-00":{"start":"2021-11-11-04-59-55","end":"2021-11-11-04-59-55","uri":"http:\/\/c18.radioboss.fm:8293\/stream","row_id":53,"type":"stream_buffer_start","independent_event":true},"2021-11-11-05-00-00_0":{"id":1,"type":"stream_output_start","row_id":53,"uri":"http:\/\/c18.radioboss.fm:8293\/stream","start":"2021-11-11-05-00-00","end":"2021-11-11-19-00-00","show_name":"RDV-CEN","independent_event":true},"2021-11-11-18-59-59":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_buffer_end","row_id":53,"independent_event":true},"2021-11-11-18-59-59_0":{"start":"2021-11-11-18-59-59","end":"2021-11-11-18-59-59","uri":"http:\/\/c18.radioboss.fm:8293\/stream","type":"stream_output_end","independent_event":true}}},"event_type":"update_schedule"}
2021-11-10 10:00:51,399 [pypofetch] [INFO ]  Handling command: update_schedule
2021-11-10 10:00:51,430 [pypofetch] [INFO ]  New timeout: 400
2021-11-10 10:00:51,430 [pypofetch] [INFO ]  Loop #12
2021-11-10 10:00:57,795 [pypoliqqueue] [INFO ]  New schedule received: {'2021-11-10-18-59-59': {'start': datetime.datetime(2021, 11, 10, 18, 59, 59), 'end': datetime.datetime(2021, 11, 10, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_buffer_end', 'row_id': 48, 'independent_event': True}, '2021-11-10-18-59-59_0': {'start': datetime.datetime(2021, 11, 10, 18, 59, 59), 'end': datetime.datetime(2021, 11, 10, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_output_end', 'independent_event': True}, '2021-11-11-05-00-00': {'start': datetime.datetime(2021, 11, 11, 4, 59, 55), 'end': datetime.datetime(2021, 11, 11, 4, 59, 55), 'uri': 'http://c18.radioboss.fm:8293/stream', 'row_id': 53, 'type': 'stream_buffer_start', 'independent_event': True}, '2021-11-11-05-00-00_0': {'id': 1, 'type': 'stream_output_start', 'row_id': 53, 'uri': 'http://c18.radioboss.fm:8293/stream', 'start': datetime.datetime(2021, 11, 11, 5, 0), 'end': datetime.datetime(2021, 11, 11, 19, 0), 'show_name': 'RDV-CEN', 'independent_event': True}, '2021-11-11-18-59-59': {'start': datetime.datetime(2021, 11, 11, 18, 59, 59), 'end': datetime.datetime(2021, 11, 11, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_buffer_end', 'row_id': 53, 'independent_event': True}, '2021-11-11-18-59-59_0': {'start': datetime.datetime(2021, 11, 11, 18, 59, 59), 'end': datetime.datetime(2021, 11, 11, 18, 59, 59), 'uri': 'http://c18.radioboss.fm:8293/stream', 'type': 'stream_output_end', 'independent_event': True}}
2021-11-10 10:00:57,810 [pypoliqqueue] [INFO ]  waiting 43141.203388s until next scheduled item
2021-11-10 10:07:08,403 [recorder] [INFO ]  Parsing recording show schedules...
2021-11-10 10:07:08,406 [recorder] [INFO ]  updated recorder schedule received: {'shows': [], 'is_recording': False, 'server_timezone': 'Europe/Moscow'}
2021-11-10 10:07:31,456 [pypofetch] [INFO ]  Queue timeout. Fetching schedule manually
2021-11-10 10:07:32,270 [pypofetch] [INFO ]  Loop #13
2021-11-10 10:07:32,360 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 10:07:32,361 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 10:14:12,272 [pypofetch] [INFO ]  Queue timeout. Fetching schedule manually
2021-11-10 10:14:12,497 [pypofetch] [INFO ]  Loop #14
2021-11-10 10:14:12,502 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 10:14:12,504 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021-11-10 10:20:52,498 [pypofetch] [INFO ]  Queue timeout. Fetching schedule manually
2021-11-10 10:20:52,737 [pypofetch] [INFO ]  Loop #15
2021-11-10 10:20:52,738 [pypoliqqueue] [INFO ]  New schedule received: {}
2021-11-10 10:20:52,739 [pypoliqqueue] [INFO ]  waiting indefinitely for schedule
2021/11/10 13:04:35 [server:3] New client: localhost.
2021/11/10 13:04:35 [lang:3] dynamic_source.get_id
2021/11/10 13:04:35 [server:3] Client localhost disconnected.
2021/11/10 13:04:35 [server:3] New client: localhost.
2021/11/10 13:04:35 [lang:3] dynamic_source.id
2021/11/10 13:04:35 [server:3] Client localhost disconnected.
2021/11/10 13:04:35 [server:3] New client: localhost.
2021/11/10 13:04:35 [lang:3] dynamic_source.output_stop
2021/11/10 13:04:35 [server:3] Client localhost disconnected.
2021/11/10 13:04:35 [http:2] Feeding stopped: source stopped
2021/11/10 13:04:35 [dummy(dot)4:3] Source failed (no more tracks) stopping output...
2021/11/10 13:04:35 [schedule_noise_switch:3] Switch to map_metadata_5859 with forgetful transition.
2021/11/10 13:04:35 [lang:3] transition called...
2021/11/10 13:04:37 [cross_5844:3] No next track ready yet.
2021/11/10 13:04:37 [lang:3] URL now http://c18.radioboss.fm (change: false)
2021/11/10 13:04:37 [lang:3] New track inside HTTP stream
2021/11/10 13:04:37 [lang:3]   status: stopped
2021/11/10 13:04:37 [lang:3]   need to cross: false
2021/11/10 13:04:37 [lang:3]   remaining inf sec before, 0. sec after
2021/11/10 13:04:40 [dummy(dot)2:3] Source failed (no more tracks) stopping output...