Announcement

Collapse
No announcement yet.

Stream restarting everyday at the same time

Collapse
X
 
  • Filter
  • Time
  • Show
Clear All
new posts

  • Stream restarting everyday at the same time

    Hi,

    One of the streams on my station currently running 2.4.7.256 has started restarting everyday at pretty much exactly the same time (11.30pm) and I'm not sure why. The only information I can find in my logs is below. Please help!

    2017-04-04 06:25:36 INFO [MAIN] Shutdown after 23 hours 55 minutes 35 seconds running
    2017-04-03 06:25:33 INFO [MAIN] Shutdown after 23 hours 55 minutes 32 seconds running

    and

    2017-04-04 06:23:30 INFO [YP] Updating listing details for stream #1 succeeded.
    2017-04-04 06:23:31 INFO [YP] Updating listing details for stream #2 succeeded.
    2017-04-04 06:23:31 INFO [YP] Updating listing details for stream #3 succeeded.
    2017-04-04 06:25:35 INFO [MAIN] Exiting threads...
    2017-04-04 06:25:35 INFO [MAIN] Terminating listeners...
    2017-04-04 06:25:35 INFO [MAIN] Terminating sources...
    2017-04-04 06:25:35 INFO [MAIN] Running Directory cleanup...
    2017-04-04 06:25:35 INFO [YP] Stream #1 has been removed from the SHOUTcast Directory.
    2017-04-04 06:25:35 INFO [SRC <IP>] SHOUTcast 1 source disconnected.
    2017-04-04 06:25:35 INFO [SRC <IP>] SHOUTcast 1 source disconnected.
    2017-04-04 06:25:35 INFO [SRC <IP>] SHOUTcast 1 source disconnected.
    2017-04-04 06:25:35 INFO [YP] Stream #2 has been removed from the SHOUTcast Directory.
    2017-04-04 06:25:36 INFO [YP] Stream #3 has been removed from the SHOUTcast Directory.
    2017-04-04 06:25:36 INFO [BANDWIDTH] Total: 30957424248, Sent: 20651645853, Recv: 10301019880
    2017-04-04 06:25:36 INFO [MAIN] Shutdown after 23 hours 55 minutes 35 seconds running

    Thanks.

    Hugh

  • #2
    anything at all interesting BEFORE

    code:
    2017-04-04 06:23:30
    "If you don't like DNAS, write your own damn system"

    So I did

    Comment


    • #3
      looks like a graceful shutdown... what platform? win, linux... does the system also shutdown, or go into sleep or suspend?
      /* v2 HTML5 / Player test pages DigitalMixNYC, DigitalMixNYCbx | DNAS Status: Now Playing js codes (scaststatus_X.php) | PortForward.com | Upload/Download Speed Test | No-IP.com: Free Dynamic DNS | In the YP | dnasDir */

      Comment


      • #4
        No general shutdown, only the stream. Could this be a playlist scheduling bug?

        Comment


        • #5
          Originally Posted by partyvibe View Post
          No general shutdown, only the stream. Could this be a playlist scheduling bug?
          Yes. If a source is disconnected, then DNAS will stop the service. It seems your playlist schedule is not looping.

          Comment


          • #6
            The same event again with debug log enabled...

            2017-04-06 06:25:34 DEBUG [DST 89.136.17.252 sid=2] state_Stream
            2017-04-06 06:25:34 DEBUG [DST 89.136.17.252 sid=2] state_Stream
            2017-04-06 06:25:34 INFO [MAIN] Exiting threads...
            2017-04-06 06:25:34 INFO [MAIN] Terminating listeners...
            2017-04-06 06:25:34 INFO [MAIN] Terminating sources...
            2017-04-06 06:25:34 DEBUG [YP] Sending remove for key=1 state=2 serverId=967122 title= genre=Rock genre2= genre3= genre4= genre5= logo=
            2017-04-06 06:25:34 DEBUG [YP] pvt_queue_remove key=1
            <?xml version="1.0" encoding="utf-8"?><yp version="2"><cmd op="remove" seq="1"><tstamp>1491485134</tstamp><url><protocol>http</protocol><port>8032</port><path>/stream</path><sid>1</sid><alt></alt></url><id>967122</id><peak>0</peak><maxclients>1500</maxclients><authhash><AUTHHASH></authhash></cmd></yp>
            2017-04-06 06:25:34 DEBUG [YP] Sending remove for key=2 state=2 serverId=948938 title= genre=Alternative genre2= genre3= genre4= genre5= logo=
            2017-04-06 06:25:34 DEBUG [YP] pvt_queue_remove key=2
            <?xml version="1.0" encoding="utf-8"?><yp version="2"><cmd op="remove" seq="1"><tstamp>1491485134</tstamp><url><protocol>http</protocol><port>8032</port><path>/stream2</path><sid>2</sid><alt></alt></url><id>948938</id><peak>0</peak><maxclients>1500</maxclients><authhash><AUTHHASH></authhash></cmd></yp>
            2017-04-06 06:25:34 DEBUG [YP] Sending remove for key=3 state=2 serverId=1018401 title= genre=Psychedelic genre2= genre3= genre4= genre5= logo=
            2017-04-06 06:25:34 DEBUG [YP] pvt_queue_remove key=3
            <?xml version="1.0" encoding="utf-8"?><yp version="2"><cmd op="remove" seq="1"><tstamp>1491485134</tstamp><url><protocol>http</protocol><port>8032</port><path>/stream3</path><sid>3</sid><alt></alt></url><id>1018401</id><peak>0</peak><maxclients>1500</maxclients><authhash><AUTHHASH></authhash></cmd></yp>
            2017-04-06 06:25:34 INFO [MAIN] Running Directory cleanup...
            2017-04-06 06:25:34 DEBUG [YP] Recycling curl handle for: https://yp.shoutcast.com/yp2
            2017-04-06 06:25:34 DEBUG [YP] Request URL: https://yp.shoutcast.com/yp2
            2017-04-06 06:25:34 DEBUG [THREADRUNNER] Removing microServer from thread 2
            2017-04-06 06:25:34 DEBUG [THREADRUNNER] Removing protocol_shoutcastSource from thread 2
            2017-04-06 06:25:34 INFO [DST ec2-54-175-246-167.compute-1.amazonaws.com sid=1] Kicked [Agent: `Bose Monitoring Service', UID: 22, GRID: 0]
            2017-04-06 06:25:34 DEBUG [THREADRUNNER] Removing protocol_shoutcast1Client from thread 2
            2017-04-06 06:25:34 DEBUG [SRC <IP>] ~protocol_shoutcastSource
            2017-04-06 06:25:34 INFO [SRC <IP>] SHOUTcast 1 source disconnected.
            2017-04-06 06:25:34 DEBUG [DST ec2-54-175-246-167.compute-1.amazonaws.com sid=1] ~protocol_shoutcast1Client
            2017-04-06 06:25:34 INFO [DST ec2-54-175-246-167.compute-1.amazonaws.com sid=1] SHOUTcast 1 client connection closed (85797 seconds) [Bytes: 3432315831] Agent: `Bose Monitoring Service', UID: 22, GRID: 0
            2017-04-06 06:25:34 DEBUG [STATS] System wide listener total now 8
            2017-04-06 06:25:34 DEBUG [THREADRUNNER] Removing microServer from thread 1
            2017-04-06 06:25:34 DEBUG [THREADRUNNER] Removing protocol_shoutcastSource from thread 1
            2017-04-06 06:25:34 DEBUG [SRC <IP>] ~protocol_shoutcastSource
            2017-04-06 06:25:34 INFO [SRC <IP>] SHOUTcast 1 source disconnected.
            2017-04-06 06:25:34 DEBUG [THREADRUNNER] Removing protocol_shoutcastSource from thread 8
            2017-04-06 06:25:34 DEBUG [SRC <IP>] ~protocol_shoutcastSource
            2017-04-06 06:25:34 INFO [SRC <IP>] SHOUTcast 1 source disconnected.
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: HTTP/1.1 200 OK
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Server: nginx
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Date: Thu, 06 Apr 2017 13:27:03 GMT
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Content-Type: text/xml;charset=UTF-8
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Content-Length: 79
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Connection: keep-alive
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Keep-Alive: timeout=600
            2017-04-06 06:25:34 DEBUG [YP] HTTP body: <?xml version="1.0" encoding="UTF-8"?>^M
            <yp version="2"><resp seq="1" /></yp>^M

            2017-04-06 06:25:34 DEBUG [YP] gotResponse Request key=1 cmd=1
            Response body=[
            <?xml version="1.0" encoding="UTF-8"?>^M
            <yp version="2"><resp seq="1" /></yp>^M
            ]
            Response code=[200]
            2017-04-06 06:25:34 DEBUG [YP] response_remove Erasing serverMap entry for key=1
            2017-04-06 06:25:34 INFO [YP] Stream #1 has been removed from the SHOUTcast Directory.
            2017-04-06 06:25:34 DEBUG [YP] Recycling curl handle for: https://yp.shoutcast.com/yp2
            2017-04-06 06:25:34 DEBUG [YP] Request URL: https://yp.shoutcast.com/yp2
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: HTTP/1.1 200 OK
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Server: nginx
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Date: Thu, 06 Apr 2017 13:25:34 GMT
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Content-Type: text/xml;charset=UTF-8
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Content-Length: 79
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Connection: keep-alive
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Keep-Alive: timeout=600
            2017-04-06 06:25:34 DEBUG [YP] HTTP body: <?xml version="1.0" encoding="UTF-8"?>^M
            <yp version="2"><resp seq="1" /></yp>^M

            2017-04-06 06:25:34 DEBUG [YP] gotResponse Request key=2 cmd=1
            Response body=[
            <?xml version="1.0" encoding="UTF-8"?>^M
            <yp version="2"><resp seq="1" /></yp>^M
            ]
            Response code=[200]
            2017-04-06 06:25:34 DEBUG [YP] response_remove Erasing serverMap entry for key=2
            2017-04-06 06:25:34 INFO [YP] Stream #2 has been removed from the SHOUTcast Directory.
            2017-04-06 06:25:34 DEBUG [YP] Recycling curl handle for: https://yp.shoutcast.com/yp2
            2017-04-06 06:25:34 DEBUG [YP] Request URL: https://yp.shoutcast.com/yp2
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: HTTP/1.1 200 OK
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Server: nginx
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Date: Thu, 06 Apr 2017 13:25:34 GMT
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Content-Type: text/xml;charset=UTF-8
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Content-Length: 79
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Connection: keep-alive
            2017-04-06 06:25:34 DEBUG [YP] HTTP header: Keep-Alive: timeout=600
            2017-04-06 06:25:34 DEBUG [YP] HTTP body: <?xml version="1.0" encoding="UTF-8"?>^M
            <yp version="2"><resp seq="1" /></yp>^M

            2017-04-06 06:25:34 DEBUG [YP] gotResponse Request key=3 cmd=1
            Response body=[
            <?xml version="1.0" encoding="UTF-8"?>^M
            <yp version="2"><resp seq="1" /></yp>^M
            ]
            Response code=[200]
            2017-04-06 06:25:34 DEBUG [YP] response_remove Erasing serverMap entry for key=3
            2017-04-06 06:25:34 INFO [YP] Stream #3 has been removed from the SHOUTcast Directory.
            2017-04-06 06:25:34 INFO [DST vox31.vox.rocks sid=1] Kicked [Agent: `OnlineRadioBox HisBot (http://onlineradiobox.com/hisbot) Chrome/47.0.2526.106', UID: 23, GRID: 0]
            2017-04-06 06:25:34 DEBUG [THREADRUNNER] Removing protocol_shoutcast1Client from thread 3
            2017-04-06 06:25:34 DEBUG [DST vox31.vox.rocks sid=1] ~protocol_shoutcast1Client
            2017-04-06 06:25:34 INFO [DST vox31.vox.rocks sid=1] SHOUTcast 1 client connection closed (85791 seconds) [Bytes: 3432085953] Agent: `OnlineRadioBox HisBot (http://onlineradiobox.com/hisbot) Chrome/47.0.2526.106', UID: 23, GRID: 0
            2017-04-06 06:25:34 DEBUG [STATS] System wide listener total now 7
            2017-04-06 06:25:34 DEBUG [DST host-24-54-188-218.beyondbb.com sid=1] ~protocol_shoutcast1Client
            2017-04-06 06:25:34 INFO [DST host-24-54-188-218.beyondbb.com sid=1] SHOUTcast 1 client connection closed (48779 seconds) [Bytes: 1952036060] Agent: `Nullsoft Winamp3 version 3.0 (compatible)', UID: 716, GRID: 0
            2017-04-06 06:25:34 DEBUG [STATS] System wide listener total now 6
            2017-04-06 06:25:34 DEBUG [DST 5x18x232x82.static-business.iz.ertelecom.ru sid=1] ~protocol_shoutcast1Client
            2017-04-06 06:25:34 INFO [DST 5x18x232x82.static-business.iz.ertelecom.ru sid=1] SHOUTcast 1 client connection closed (9340 seconds) [Bytes: 374057284] Agent: `RaimaRadio', UID: 1461, GRID: 0
            2017-04-06 06:25:34 DEBUG [STATS] System wide listener total now 5
            2017-04-06 06:25:34 DEBUG [DST 89.136.17.252 sid=2] ~protocol_shoutcast2Client
            2017-04-06 06:25:34 INFO [DST 89.136.17.252 sid=2] SHOUTcast 2 client connection closed (6361 seconds) [Bytes: 256015040] Agent: `WinampMPEG/5.66, Ultravox/2.1', UID: 1494, GRID: 0
            2017-04-06 06:25:34 DEBUG [STATS] System wide listener total now 4
            2017-04-06 06:25:34 DEBUG [DST static.34.1.9.176.clients.your-server.de sid=1] ~protocol_shoutcast1Client
            2017-04-06 06:25:34 INFO [DST static.34.1.9.176.clients.your-server.de sid=1] SHOUTcast 1 client connection closed (86041 seconds) [Bytes: 4339529675] Agent: `WinampMPEG/5.54', UID: 5, GRID: 0
            2017-04-06 06:25:34 DEBUG [STATS] System wide listener total now 3
            2017-04-06 06:25:34 DEBUG [DST aftr-95-223-108-86.unity-media.net sid=1] ~protocol_shoutcast1Client
            2017-04-06 06:25:34 INFO [DST aftr-95-223-108-86.unity-media.net sid=1] SHOUTcast 1 client connection closed (4273 seconds) [Bytes: 171380517] Agent: `', UID: 1551, GRID: 0
            2017-04-06 06:25:34 DEBUG [STATS] System wide listener total now 2
            2017-04-06 06:25:34 DEBUG [DST 165.225.64.55 sid=1] ~protocol_shoutcast1Client
            2017-04-06 06:25:34 INFO [DST 165.225.64.55 sid=1] SHOUTcast 1 client connection closed (5586 seconds) [Bytes: 223864696] Agent: `Mozilla/5.0 (Windows NT 5.1; rv:52.0) Gecko/20100101 Firefox/52.0', UID: 1506, GRID: 0
            2017-04-06 06:25:34 DEBUG [STATS] System wide listener total now 1
            2017-04-06 06:25:34 DEBUG [DST static.145.58.99.88.clients.your-server.de sid=1] ~protocol_shoutcast1Client
            2017-04-06 06:25:34 INFO [DST static.145.58.99.88.clients.your-server.de sid=1] SHOUTcast 1 client connection closed (85700 seconds) [Bytes: 3295862609] Agent: `WinampMPEG/5.50', UID: 27, GRID: 0
            2017-04-06 06:25:34 DEBUG [STATS] System wide listener total now 0
            2017-04-06 06:25:34 INFO [STATS] Peak numbers: #1:18,#2:2,#3:2,Total: 22
            2017-04-06 06:25:34 INFO [BANDWIDTH] Total: 42318287744, Sent: 32000901577, Recv: 10300832062
            2017-04-06 06:25:34 INFO [MAIN] Shutdown after 23 hours 55 minutes 33 seconds running

            Comment


            • #7
              Do you have checked your source?

              Comment


              • #8
                Originally Posted by djSpinnerCee View Post
                looks like a graceful shutdown... what platform? win, linux... does the system also shutdown, or go into sleep or suspend?
                I'm running Debian Jessie and SHOUTcast iscthe only thing to shutdown.

                Comment


                • #9
                  I had a similar issue with my server and VPN tunnel collapsing at the same time everyday on a windows machine... I wasn't sure where it was coming from, but eventually, while combing through the 'scheduled events' logs of what had run at what time, I found that there was a program re-registering the windows key every day at time. (Evidently, the dealer who sold it had a pirated copy of windows on it and that was an sloppy method of keeping it evergreen)

                  You may look through all of the event logs you can find for that particular time, perhaps something there will be a clue to help.
                  Wow Machine Radio -- Where You Never Know What You'll Hear Next!
                  code:
                  Streaming Radio | Podcast Production | Processing Labs
                  Listen Live

                  Comment


                  • #10
                    check your crontab -l and at jobs... also check if the DNAS server is running with nohup so it can
                    't be stopped if the shell that srarted it dies, sleeps, hangs, or is otherwise interrupted.
                    /* v2 HTML5 / Player test pages DigitalMixNYC, DigitalMixNYCbx | DNAS Status: Now Playing js codes (scaststatus_X.php) | PortForward.com | Upload/Download Speed Test | No-IP.com: Free Dynamic DNS | In the YP | dnasDir */

                    Comment

                    Working...
                    X
                    😀
                    🥰
                    🤢
                    😎
                    😡
                    👍
                    👎