Dropped Connections

[Bloo]

Hi,

I'm seeking some ideas on a problem I'm having.

I have my own dedicated server that I set up Shoutcast on to broadcast our church services.

The server is running fine and has plenty of available bandwidth.

I've done some testing from home (1.5meg DSL)and had a couple friends listen with no problems. I decided to go live today at church and had two listeners. Both listeners reported that they kept getting dropped after 6 minutes and 30 seconds of listening.

At church, I was broadcasting from my laptop through a Wi-Fi connection to a 256k up/down DSL connection.

As near as I could tell through WinAmp, I was not losing connection to the server. The status showed a continuous amount of bandwidth and connection time. If I was losing connection at the Wi-Fi level, I should be able to tell that from the WinAmp interface, right?

Before I start to pull 100' of cat5 through the insulation in the attic to get a wired connection to the sound booth, does anyone see any significance of the 6-1/2 minute connection then drop problem? Now, I don't know if both users were getting dropped at the same time, but they both did report that it was right at 6-1/2 minutes between drops.

Thanks for any advice you may have.

[Tom]

Do you have access to the log file the DNAS creates?

Tom

[Bloo]

Yes, I do. This is the entire log from the time I started broadcasting until I stopped.

<11/26/06@09:51:41> [SHOUTcast] DNAS/Linux v1.9.7 (Jun 23 2006) starting up...
<11/26/06@09:51:41> [main] pid: 15150
<11/26/06@09:51:41> [main] loaded config from sc_serv.conf
<11/26/06@09:51:41> [main] initializing (usermax:15 portbase:3000)...
<11/26/06@09:51:41> [main] Listener Max Connect of (300) Minutes, set.
<11/26/06@09:51:41> [main] No ban file found (sc_serv.ban)
<11/26/06@09:51:41> [main] No rip file found (sc_serv.rip)
<11/26/06@09:51:41> [main] opening source socket
<11/26/06@09:51:41> [main] source thread starting
<11/26/06@09:51:41> [main] opening client socket
<11/26/06@09:51:41> [source] listening for connection on port 3001
<11/26/06@09:51:41> [main] Client Stream thread [0] starting
<11/26/06@09:51:41> [main] client main thread starting
<11/26/06@09:51:57> [source] connected from 71.215.42.52
<11/26/06@09:51:58> [source] icy-name:BowEFC Sermons ; icy-genre:Vocal
<11/26/06@09:51:58> [source] icy-pub:0 ; icy-br:24 ; icy-url:http://bowefc.org
<11/26/06@09:51:58> [source] icy-irc:N/A ; icy-icq:N/A ; icy-aim:N/A
<11/26/06@10:06:18> [dest: 208.107.154.32] starting stream (UID: 0)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@10:06:18> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 0)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@10:06:18> [dest: 208.107.154.32] starting stream (UID: 1)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@10:06:18> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 1)[L: 0]{Bytes: 16384}(P: 0)
<11/26/06@10:06:18> [dest: 208.107.154.32] starting stream (UID: 2)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@10:15:38> [dest: 208.107.154.32] connection closed (560 seconds) (UID: 2)[L: 0]{Bytes: 1934628}(P: 0)
<11/26/06@10:15:44> [dest: 208.107.154.32] starting stream (UID: 3)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@10:15:44> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 3)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@10:15:44> [dest: 208.107.154.32] starting stream (UID: 4)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@10:15:44> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 4)[L: 0]{Bytes: 16384}(P: 0)
<11/26/06@10:15:44> [dest: 208.107.154.32] starting stream (UID: 5)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@10:30:53> [dest: 208.107.154.32] connection closed (909 seconds) (UID: 5)[L: 0]{Bytes: 2981776}(P: 0)
<11/26/06@10:31:03> [dest: 208.107.154.32] starting stream (UID: 6)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@10:31:03> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 6)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@10:31:03> [dest: 208.107.154.32] starting stream (UID: 7)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@10:31:03> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 7)[L: 0]{Bytes: 14482}(P: 0)
<11/26/06@10:31:03> [dest: 208.107.154.32] starting stream (UID: 8)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@10:33:44> [main] SIGWINCH; Reloaded Config File
<11/26/06@10:36:03> [dest: 208.107.154.32] connection closed (301 seconds) (UID: 8)[L: 0]{Bytes: 1155810}(P: 0)
<11/26/06@10:45:08> [dest: 208.107.154.32] starting stream (UID: 9)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@10:45:08> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 9)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@10:45:08> [dest: 208.107.154.32] starting stream (UID: 10)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@10:45:08> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 10)[L: 0]{Bytes: 18862}(P: 0)
<11/26/06@10:45:08> [dest: 208.107.154.32] starting stream (UID: 11)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@10:50:09> [dest: 208.107.154.32] connection closed (301 seconds) (UID: 11)[L: 0]{Bytes: 1157770}(P: 0)
<11/26/06@10:53:30> [dest: 209.181.156.226] starting stream (UID: 12)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@10:53:31> [dest: 209.181.156.226] connection closed (0 seconds) (UID: 12)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@10:53:31> [dest: 209.181.156.226] starting stream (UID: 13)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@10:53:31> [dest: 209.181.156.226] connection closed (0 seconds) (UID: 13)[L: 0]{Bytes: 14482}(P: 0)
<11/26/06@10:53:31> [dest: 209.181.156.226] starting stream (UID: 14)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@10:58:31> [dest: 209.181.156.226] connection closed (301 seconds) (UID: 14)[L: 0]{Bytes: 1155817}(P: 0)
<11/26/06@11:01:08> [dest: 209.181.156.226] starting stream (UID: 15)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@11:01:09> [dest: 209.181.156.226] connection closed (0 seconds) (UID: 15)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@11:01:09> [dest: 209.181.156.226] starting stream (UID: 16)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:01:09> [dest: 209.181.156.226] connection closed (0 seconds) (UID: 16)[L: 0]{Bytes: 16384}(P: 0)
<11/26/06@11:01:09> [dest: 209.181.156.226] starting stream (UID: 17)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:01:40> [dest: 208.107.154.32] starting stream (UID: 18)[L: 2]{A: NSPlayer/10.0.0.3802}(P: 1)
<11/26/06@11:01:40> [dest: 208.107.154.32] connection closed (1 seconds) (UID: 18)[L: 1]{Bytes: 11562}(P: 1)
<11/26/06@11:01:40> [dest: 208.107.154.32] starting stream (UID: 19)[L: 2]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 1)
<11/26/06@11:01:41> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 19)[L: 1]{Bytes: 14482}(P: 1)
<11/26/06@11:01:41> [dest: 208.107.154.32] starting stream (UID: 20)[L: 2]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 1)
<11/26/06@11:06:09> [dest: 209.181.156.226] connection closed (301 seconds) (UID: 17)[L: 1]{Bytes: 1156207}(P: 0)
<11/26/06@11:06:41> [dest: 208.107.154.32] connection closed (301 seconds) (UID: 20)[L: 0]{Bytes: 1157927}(P: 1)
<11/26/06@11:07:59> [dest: 209.181.156.226] starting stream (UID: 21)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@11:07:59> [dest: 209.181.156.226] connection closed (0 seconds) (UID: 21)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@11:07:59> [dest: 209.181.156.226] starting stream (UID: 22)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:07:59> [dest: 209.181.156.226] connection closed (0 seconds) (UID: 22)[L: 0]{Bytes: 14482}(P: 0)
<11/26/06@11:07:59> [dest: 209.181.156.226] starting stream (UID: 23)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:12:59> [dest: 209.181.156.226] connection closed (301 seconds) (UID: 23)[L: 0]{Bytes: 1157231}(P: 0)
<11/26/06@11:14:29> [dest: 209.181.156.226] starting stream (UID: 24)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@11:14:29> [dest: 209.181.156.226] connection closed (0 seconds) (UID: 24)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@11:14:29> [dest: 209.181.156.226] starting stream (UID: 25)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:14:30> [dest: 209.181.156.226] connection closed (0 seconds) (UID: 25)[L: 0]{Bytes: 16384}(P: 0)
<11/26/06@11:14:30> [dest: 209.181.156.226] starting stream (UID: 26)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:18:36> [dest: 68.251.250.143] starting stream (UID: 27)[L: 2]{A: NSPlayer/10.0.0.3650}(P: 1)
<11/26/06@11:18:36> [dest: 68.251.250.143] connection closed (0 seconds) (UID: 27)[L: 1]{Bytes: 14402}(P: 1)
<11/26/06@11:18:36> [dest: 68.251.250.143] starting stream (UID: 28)[L: 2]{A: NSPlayer/10.0.0.3650 WMFSDK/10.0}(P: 1)
<11/26/06@11:18:37> [dest: 68.251.250.143] connection closed (1 seconds) (UID: 28)[L: 1]{Bytes: 55068}(P: 1)
<11/26/06@11:18:37> [dest: 68.251.250.143] starting stream (UID: 29)[L: 2]{A: NSPlayer/10.0.0.3650 WMFSDK/10.0}(P: 1)
<11/26/06@11:19:06> [dest: 68.251.250.143] connection closed (30 seconds) (UID: 29)[L: 1]{Bytes: 344318}(P: 1)
<11/26/06@11:19:30> [dest: 209.181.156.226] connection closed (301 seconds) (UID: 26)[L: 0]{Bytes: 1157612}(P: 0)
<11/26/06@11:39:37> [dest: 208.107.154.32] starting stream (UID: 30)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@11:39:37> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 30)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@11:39:37> [dest: 208.107.154.32] starting stream (UID: 31)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:39:38> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 31)[L: 0]{Bytes: 14482}(P: 0)
<11/26/06@11:39:38> [dest: 208.107.154.32] starting stream (UID: 32)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:44:39> [dest: 208.107.154.32] connection closed (301 seconds) (UID: 32)[L: 0]{Bytes: 1158946}(P: 0)
<11/26/06@11:46:25> [dest: 208.107.154.32] starting stream (UID: 33)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@11:46:25> [dest: 208.107.154.32] connection closed (1 seconds) (UID: 33)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@11:46:25> [dest: 208.107.154.32] starting stream (UID: 34)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:46:25> [dest: 208.107.154.32] connection closed (0 seconds) (UID: 34)[L: 0]{Bytes: 14482}(P: 0)
<11/26/06@11:46:25> [dest: 208.107.154.32] starting stream (UID: 35)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:48:00> [dest: 208.107.154.32] connection closed (94 seconds) (UID: 35)[L: 0]{Bytes: 539377}(P: 0)
<11/26/06@11:52:01> [dest: 209.181.156.226] starting stream (UID: 36)[L: 1]{A: NSPlayer/10.0.0.3802}(P: 0)
<11/26/06@11:52:01> [dest: 209.181.156.226] connection closed (0 seconds) (UID: 36)[L: 0]{Bytes: 11562}(P: 0)
<11/26/06@11:52:01> [dest: 209.181.156.226] starting stream (UID: 37)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:52:01> [dest: 209.181.156.226] connection closed (0 seconds) (UID: 37)[L: 0]{Bytes: 16384}(P: 0)
<11/26/06@11:52:01> [dest: 209.181.156.226] starting stream (UID: 38)[L: 1]{A: NSPlayer/10.0.0.3802 WMFSDK/10.0}(P: 0)
<11/26/06@11:57:02> [dest: 209.181.156.226] connection closed (301 seconds) (UID: 38)[L: 0]{Bytes: 1157539}(P: 0)
<11/26/06@12:04:13> [source] source dropped connection. disconnecting.
<11/26/06@12:04:41> [main] SIGINT; exiting!

There are so many "starting" and "connection closed" messages in the same second, I don't know what is normal.

[Tom]

<11/26/06@09:51:41> [main] Listener Max Connect of (300) Minutes, set.

That's what's responsible for kicking your listeners. It says minutes but your listeners are getting kicked at 301 sec and I thought I remember an issue of min vs. seconds on that setting. Anyway try changing or disabling that and see what that does for you, also there are no signs of you losing the source connection so there's no need to go into the attic.

Tom

[Bloo]

Ah ha . . . thank you!

Now that you point it out and I see it, it should have been obvious. Timer set to 300, connections closed at 301. Since the config file said "minutes" I didn't even consider that.

I will completely disable the timer for next week and see what happens. I just thought I'd set it high in case I went off and forgot to turn off the stream and users forgot to close their players, they wouldn't be playing silent bandwidth all day.

I suppose in my testing, I was listening from other machines on a network with the same public IP so the timer ignored those . . . it makes sense.

Thanks again, Tom. Sometimes we just need someone to point out the obvious.

[industriadelweb]

Hello I have the same problem you can view my log:

<08/22/07@13:42:14> [dest: 201.230.103.60] starting stream (UID: 4)[L: 1]{A: NSPlayer/11.0.5721.5145 WMFSDK/11.0}(P: 0)
<08/22/07@13:42:14> [dest: 201.230.103.60] connection closed (1 seconds) (UID: 4)[L: 0]{Bytes: 17294}(P: 0)
<08/22/07@13:42:15> [dest: 201.230.103.60] starting stream (UID: 5)[L: 1]{A: NSPlayer/11.0.5721.5145 WMFSDK/11.0}(P: 0)
<08/22/07@13:42:16> [dest: 201.230.103.60] connection closed (1 seconds) (UID: 5)[L: 0]{Bytes: 56498}(P: 0)
<08/22/07@13:42:16> [dest: 201.230.103.60] starting stream (UID: 6)[L: 1]{A: Windows-Media-Player/11.0.5721.5145}(P: 0)
<08/22/07@13:42:17> [dest: 201.230.103.60] connection closed (0 seconds) (UID: 6)[L: 0]{Bytes: 14390}(P: 0)

What could be the problem? thank you.

Joel Guillen

[dotme]

Originally posted by industriadelweb
What could be the problem? thank you.

Joel Guillen

This is the problem:
http://forums.winamp.com/showthread....hreadid=270847

Nothing to be too concerned about.

[coskel]

I am having the same problem - I have disabled the Listener connection timer, and have also re-loaded a fresh config file, but am still getting the same error.

Any suggestions?

Shoutcast running on a remote Linux box.