Old 19th March 2012, 17:52   #1
AbidingRadio
Junior Member
 
Join Date: Mar 2012
Posts: 2
Dropped Connections at the Top of the Hour using DNAS2

Well, I've got a strange one for you. We've been running an Internet radio station for a few years now on old crusty hardware and are attempting to set up a fresh pair of servers to take over.

Our encoding server is running Sam 4.9.4 on Windows 2008 R2 x64. Our streaming server is running DNAS2 build 29, also on Windows 2008 R2 x64. I was able to set up two separate 96kbps MP3 streams encoding and streaming properly, and then released those streams to some test users.

Yesterday I was consistently seeing our numbers get to 100-130 users per stream, but then suddenly at the top of each hour most (all?) connections would be dropped and I'd see the connections start to re-establish themselves over the next 5-10 minutes.

The encoding server never gets over 30% CPU or 40% RAM. The streaming server never gets over about 5% CPU and 25% RAM. These are freshly installed, fully patched OSs. Is there some kind of automated stream-cleaning process that runs at the top of every hour under either DNAs2 or Win2008R2x64?

Sample from the log file:

[...]

2012-03-18 22:58:52 I msg:[YP2] Connecting to yp.shoutcast.com
2012-03-18 23:00:49 I msg:[SRC 108.166.70.58:51024 sid=1] Got complete metadata message type=3902 [562 bytes] id=884 span=1 content=
<?xml version="1.0" encoding="UTF-8"?>
<metadata><TIT2>Obedience</TIT2><TPE1>Patch the Pirate</TPE1><TALB>Sunday School Singalong</TALB><TCON>Children's Music</TCON><TLEN>117891</TLEN><TRCK>43</TRCK><TXXX id="picture">az_B314372_Sunday School Singalong_Patch the Pirate.jpg</TXXX><TXXX id="songtype">S</TXXX><TENC>SAM Broadcaster 4.9.4</TENC><TRSN>Abiding Radio Kids - Conservative, Sacred, and Traditional Christian Kids Music</TRSN><WORS>http://www.abidingradio.org</WORS><extension><title seq="1">Patch the Pirate - Obedience</title></extension></metadata>

2012-03-18 23:01:11 I msg:[YP2] Connecting to yp.shoutcast.com
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56019 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56019 sid=1] SHOUTcast 1 client connection closed (3598 seconds) [Bytes: 43430962] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56006 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56006 sid=1] SHOUTcast 1 client connection closed (3599 seconds) [Bytes: 43441759] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56188 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56188 sid=1] SHOUTcast 1 client connection closed (3199 seconds) [Bytes: 38647144] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56007 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56009 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56030 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56093 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56895 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56900 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56007 sid=1] SHOUTcast 1 client connection closed (3599 seconds) [Bytes: 43443910] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56009 sid=1] SHOUTcast 1 client connection closed (3599 seconds) [Bytes: 43443910] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56030 sid=1] SHOUTcast 1 client connection closed (3597 seconds) [Bytes: 43420306] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56093 sid=1] SHOUTcast 1 client connection closed (3594 seconds) [Bytes: 43383594] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56895 sid=1] SHOUTcast 1 client connection closed (3581 seconds) [Bytes: 43230254] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56900 sid=1] SHOUTcast 1 client connection closed (3581 seconds) [Bytes: 43228502] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56005 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56008 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56014 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56024 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56353 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56899 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56923 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:57871 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56005 sid=1] SHOUTcast 1 client connection closed (3599 seconds) [Bytes: 43443910] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56008 sid=1] SHOUTcast 1 client connection closed (3599 seconds) [Bytes: 43443910] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56014 sid=1] SHOUTcast 1 client connection closed (3598 seconds) [Bytes: 43439620] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56024 sid=1] SHOUTcast 1 client connection closed (3597 seconds) [Bytes: 43424632] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56353 sid=1] SHOUTcast 1 client connection closed (3590 seconds) [Bytes: 43344580] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56899 sid=1] SHOUTcast 1 client connection closed (3581 seconds) [Bytes: 43228502] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56923 sid=1] SHOUTcast 1 client connection closed (3581 seconds) [Bytes: 43225871] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:57871 sid=1] SHOUTcast 1 client connection closed (3170 seconds) [Bytes: 38295934] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56920 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:59730 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:34065 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56920 sid=1] SHOUTcast 1 client connection closed (3581 seconds) [Bytes: 43227610] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:59730 sid=1] SHOUTcast 1 client connection closed (3140 seconds) [Bytes: 37937827] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:34065 sid=1] SHOUTcast 1 client connection closed (3080 seconds) [Bytes: 37218964] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:60971 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:60971 sid=1] SHOUTcast 1 client connection closed (3110 seconds) [Bytes: 37584875] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56068 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 E msg:[DST 66.90.73.230:56901 sid=1] Socket error while waiting to send data. err=Connection reset by peer.(10054)
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56068 sid=1] SHOUTcast 1 client connection closed (3594 seconds) [Bytes: 43392223] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:38 I msg:[DST 66.90.73.230:56901 sid=1] SHOUTcast 1 client connection closed (3581 seconds) [Bytes: 43230656] Agent: `MixStream Radio Player V2.3 (Not Mozilla)'
2012-03-18 23:01:55 I msg:[DST 66.90.73.230:35811 sid=1] SHOUTcast 1 client connection accepted. MixStream Radio Player V2.3 (Not Mozilla)
2012-03-18 23:02:22 I msg:[DST 66.90.73.230:37272 sid=1] SHOUTcast 1 client connection accepted. MixStream Radio Player V2.3 (Not Mozilla)
2012-03-18 23:02:41 I msg:[SRC 108.166.70.58:51024 sid=1] Got complete metadata message type=3902 [613 bytes] id=885 span=1 content=
<?xml version="1.0" encoding="UTF-8"?>
<metadata><TIT2>Every Promise in the Book Is Mine</TIT2><TPE1>Patch the Pirate</TPE1><TALB>Sunday School Singalong 2</TALB><TCON>Children's Music</TCON><TLEN>45218</TLEN><TRCK>27</TRCK><TXXX id="picture">az_B314310_Sunday School Singalong 2_Patch the Pirate.jpg</TXXX><TXXX id="songtype">S</TXXX><TENC>SAM Broadcaster 4.9.4</TENC><TRSN>Abiding Radio Kids - Conservative, Sacred, and Traditional Christian Kids Music</TRSN><WORS>http://www.abidingradio.org</WORS><extension><title seq="1">Patch the Pirate - Every Promise in the Book Is Mine</title></extension></metadata>

2012-03-18 23:02:52 I msg:[DST 66.90.73.230:35610 sid=1] SHOUTcast 1 client connection accepted. MixStream Radio Player V2.3 (Not Mozilla)
2012-03-18 23:03:03 I msg:[YP2] Connecting to yp.shoutcast.com
2012-03-18 23:03:22 I msg:[SRC 108.166.70.58:51024 sid=1] Got complete metadata message type=3902 [480 bytes] id=886 span=1 content=
<?xml version="1.0" encoding="UTF-8"?>
<metadata><TIT2>John 6:38</TIT2><TPE1>Earl Martin</TPE1><TALB>Sing The Bible With Mr. E.</TALB><TCON>Kids Christian</TCON><TLEN>50469</TLEN><TCOM>Earl Martin</TCOM><TXXX id="songtype">S</TXXX><TENC>SAM Broadcaster 4.9.4</TENC><TRSN>Abiding Radio Kids - Conservative, Sacred, and Traditional Christian Kids Music</TRSN><WORS>http://www.abidingradio.org</WORS><extension><title seq="1">Earl Martin - John 6:38</title></extension></metadata>

[...]

Anyone seen this type of behavior before?
AbidingRadio is offline   Reply With Quote
Old 19th March 2012, 23:02   #2
DrO
 
Join Date: Sep 2003
Posts: 27,873
i've not seen that before and there shouldn't be anything in the DNAS which is causing a drop on the hour as nothing internally runs on that sort of time scale that i can remember. since generally everything is done immediately, with the only real timed aspect being the log rotates which unless done manually will happen ~every 24hours.

from looking at the log snippet, it's almost like the external net connection dropped out. then again if it's all just from 66.90.73.230 (as is the case with what is posted), it could be something on that end. then again i've never heard of 'MixStream Radio Player V2.3 (Not Mozilla)' before so i really don't know what to say about that as such.

-daz
DrO is offline   Reply With Quote
Old 22nd March 2012, 22:39   #3
AbidingRadio
Junior Member
 
Join Date: Mar 2012
Posts: 2
DrO, thanks for your reply. The MixStream Radio Player is a Flash-based shoutcast stream player that I got from here: http://mixstream.net/streaming/creat...dio-player.php If I ping shoutcast.mixstream.net it returns 66.90.73.230, so I must have done something wrong when I set the player up where it's relying on the other server for something. I'll continue to look into this...
AbidingRadio is offline   Reply With Quote
Old 7th April 2012, 22:32   #4
BELLonline
Senior Member
 
Join Date: Sep 2006
Posts: 254
Hello,

If you're still having problems with this then please get in touch via the mixstream website and we will look in to it.

The useragent 'MixStream Radio Player V2.3 (Not Mozilla)' is the script that connects to your server to grab the song title. The player hasn't been fully tested with ShoutcastV2 so that may be what's causing the error logs.
BELLonline is offline   Reply With Quote
Old 8th April 2012, 02:41   #5
jaromanda
Forum King
 
Join Date: Jun 2007
Location: Under the bridge
Posts: 2,289
Quote:
Originally Posted by BELLonline View Post
The useragent 'MixStream Radio Player V2.3 (Not Mozilla)' is the script that connects to your server to grab the song title.
It does more than grab the song title - judging by the number of bytes sent to each instance of MixStream, it's grabbing the full (in this case 96kbit) stream

"If you don't like DNAS, write your own damn system"

So I did
jaromanda is offline   Reply With Quote
Reply
Go Back   Winamp & Shoutcast Forums > Shoutcast > Shoutcast Technical Support

Thread Tools Search this Thread
Search this Thread:

Advanced Search
Display Modes

Posting Rules
You may not post new threads
You may not post replies
You may not post attachments
You may not edit your posts

BB code is On
Smilies are On
[IMG] code is On
HTML code is Off

Forum Jump