[Icecast] Sources can't connect to my server
Thomas B. Ruecker
dm8tbr at afthd.tu-darmstadt.de
Sun Jun 21 07:41:23 UTC 2009
Eric Kolotyluk schrieb:
> Thanks for getting back to me - I would really like to figure this out.
>
> My Icecast service is running and the address of my server is
> 14.83.23.157. Could someone try connecting to it with a source and see
> if you have any luck.
>
> More below..
>
> Thomas B. Ruecker wrote:
>> Eric Kolotyluk schrieb:
>>
>>> I have IceCast 2.3.1 running on Window XP SP3 as a windows service.
>>>
>>>
>> Regardless of the issues please consider to upgrade to 2.3.2.
>>
> OK, I have been considering it. Is there a binary version I can get
> somewhere that installs as a windows service?
on the icecast website should be an installer.
I don't know if it installs as a service as I don't use windows a lot
and haven't installed icecast on a windows for at least half a year.
>>
>>> The problem is, no source on the other side of my router can connect to
>>> my server. I can't figure out what the problem could be. Does anyone
>>> have any ideas?
>>>
>>>
>> Did you look at the error.log of your server? As you have said TCP
>> connections to the icecast server work. So the source is also able to
>> reach it (unless misconfigured etc). So unless you are trying to use
>> some weird sh*tcast dsp that connects to different port numbers there
>> should be entries in the error.log.
>>
> Yes, I even turned it up to the DBUG level so I could try and figure
> out what the problem is. I'm not that familiar with the error log so
> I'm not sure what I'm supposed to be looking for.
well, it's not very hard to read. But I'll try and give you a few hints.
> Configuration files follow
>
So let's dissect this a bit. I'll be deleting irrelevant parts of the log.
> error.log
>
> (24.83.23.157) is the external address of my server on the internet -
> outside the router.
>
> The first source connection was from my second computer
> (192.168.0.103) behind my router which seems to work fine. Is it also
> listening to the stream via Second Life.
>
> I don't understand the No such file or directory messages or how to
> fix them
>
> [2009-06-17 17:50:07] INFO fserve/fserve.c checking for file
> /different.ogg/7.html (./web/different.ogg/7.html)
> [2009-06-17 17:50:07] WARN fserve/fserve.c req for file
> "./web/different.ogg/7.html" No such file or directory
That's plain weird. something is asking for
http://24.83.23.157:8000/different.ogg/7.html - why would anyone want
this? I'll look at it again in the access log.
> [2009-06-17 17:50:09] INFO connection/connection.c Source logging in
> at mountpoint "/different.ogg"
> [2009-06-17 17:50:09] DBUG connection/connection.c sources count is 0
> [2009-06-17 17:50:09] DBUG stats/stats.c update node clients (1)
> [2009-06-17 17:50:09] DBUG stats/stats.c update node connections (2)
> [2009-06-17 17:50:09] DBUG stats/stats.c update node sources (1)
> [2009-06-17 17:50:09] DBUG source/source.c Applying mount information
> for "/different.ogg"
> [2009-06-17 17:50:09] DBUG source/source.c YP changed to 1
> [2009-06-17 17:50:09] DBUG source/source.c public set to 1
> [2009-06-17 17:50:09] DBUG source/source.c max listeners to -1
> [2009-06-17 17:50:09] DBUG source/source.c queue size to 524288
> [2009-06-17 17:50:09] DBUG source/source.c burst size to 65535
> [2009-06-17 17:50:09] DBUG source/source.c source timeout to 10
> [2009-06-17 17:50:09] DBUG source/source.c fallback_when_full to 0
> [2009-06-17 17:50:09] DBUG connection/connection.c source is ready to
> start
> [2009-06-17 17:50:09] DBUG fserve/fserve.c Adding client to file
> serving engine
> [2009-06-17 17:50:09] DBUG source/source.c Source creation complete
> [2009-06-17 17:50:09] DBUG format-ogg/format_ogg.c releasing header pages
> [2009-06-17 17:50:09] DBUG format-ogg/format_ogg.c freeing codecs
> [2009-06-17 17:50:09] DBUG format-vorbis/format_vorbis.c checking for
> vorbis codec
> [2009-06-17 17:50:09] INFO format-vorbis/format_vorbis.c seen initial
> vorbis header
> [2009-06-17 17:50:09] DBUG format-vorbis/format_vorbis.c processing
> incoming header packet (1)
> [2009-06-17 17:50:09] DBUG format-vorbis/format_vorbis.c processing
> incoming header packet (2)
> [2009-06-17 17:50:09] DBUG format-vorbis/format_vorbis.c we have the
> header packets now
> [2009-06-17 17:50:09] DBUG format-vorbis/format_vorbis.c Adding the 3
> header packets
> [2009-06-17 17:50:09] DBUG format-ogg/format_ogg.c attaching BOS page
> [2009-06-17 17:50:09] DBUG format-ogg/format_ogg.c attaching header page
> [2009-06-17 17:50:09] DBUG stats/stats.c new source stat /different.ogg
> [2009-06-17 17:50:09] DBUG stats/stats.c new node public (1)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node server_name (Quant)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node server_description
> (Second Life)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node server_url
> (http://www.audiorealm.com)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node genre (Various)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node bitrate (Quality 0.00)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node server_type
> (application/ogg)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node max_listeners
> (unlimited)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node source_ip
> (24.83.23.157)
> [2009-06-17 17:50:09] DBUG stats/stats.c update node
> source_client_connections (1)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node listeners (0)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node ice-samplerate (44100)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node ice-quality (0.00)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node ice-channels (2)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node audio_info
> (ice-samplerate=44100;ice-quality=0.00;ice-channels=2)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node listenurl
> (http://192.168.0.103:8000/different.ogg)
> [2009-06-17 17:50:09] DBUG stats/stats.c update node
> source_total_connections (1)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node slow_listeners (0)
> [2009-06-17 17:50:09] DBUG stats/stats.c update node listeners (0)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node listener_peak (0)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node stream_start (Wed,
> 17 Jun 2009 17:50:09 Pacific Daylight Time)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node total_bytes_read (0)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node total_bytes_sent (0)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node audio_samplerate
> (44100)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node audio_channels (2)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node audio_bitrate (64001)
> [2009-06-17 17:50:09] DBUG stats/stats.c new node ice-bitrate (64)
> [2009-06-17 17:50:10] DBUG stats/stats.c new node artist (Quant)
> [2009-06-17 17:50:10] DBUG stats/stats.c new node title (Second Life)
> [2009-06-17 17:50:10] DBUG stats/stats.c new node subtype (Vorbis)
looks good. A source connected. What's weird though is that the
connection according to the access.log is comming from 24.83.23.157 -
which according to you is your router's external IP.
Did you try yourself to connect to your server using your external IP?
> [2009-06-17 17:50:37] DBUG auth/auth.c max on /different.ogg is -1
> (cur 0)
> [2009-06-17 17:50:37] DBUG auth/auth.c Added client to /different.ogg
> [2009-06-17 17:50:37] DBUG auth/auth.c client authenticated, passed
> to source
> [2009-06-17 17:50:37] DBUG source/source.c Client added
> [2009-06-17 17:50:37] INFO source/source.c listener count on
> /different.ogg now 1
Now there is a listener connection
> [2009-06-17 17:50:39] DBUG stats/stats.c update node total_bytes_read
> (225731)
> [2009-06-17 17:50:39] DBUG stats/stats.c update node total_bytes_sent
> (58464)
> [2009-06-17 17:50:44] DBUG stats/stats.c update node total_bytes_read
> (263868)
> [2009-06-17 17:50:44] DBUG stats/stats.c update node total_bytes_sent
> (112936)
> [2009-06-17 17:50:49] DBUG stats/stats.c update node total_bytes_read
> (301829)
> [2009-06-17 17:50:49] DBUG stats/stats.c update node total_bytes_sent
> (151445)
> [2009-06-17 17:50:54] DBUG stats/stats.c update node total_bytes_read
> (340159)
> [2009-06-17 17:50:54] DBUG stats/stats.c update node total_bytes_sent
> (189557)
> [2009-06-17 17:50:59] DBUG stats/stats.c update node total_bytes_read
> (378328)
> [2009-06-17 17:50:59] DBUG stats/stats.c update node total_bytes_sent
> (227735)
> [2009-06-17 17:51:04] DBUG stats/stats.c update node total_bytes_read
> (416363)
> [2009-06-17 17:51:04] DBUG stats/stats.c update node total_bytes_sent
> (266305)
> [2009-06-17 17:51:09] DBUG stats/stats.c update node total_bytes_read
> (450456)
> [2009-06-17 17:51:09] DBUG stats/stats.c update node total_bytes_sent
> (299731)
This is just a statistics update but it indicates that it seems like
data is flowing fine. There is 450456 bytes that came from the source
client and 299731 bytes were sent to the listener.
> [2009-06-17 17:51:09] DBUG client/client.c Client connection died
> [2009-06-17 17:51:09] DBUG source/source.c Client removed
> [2009-06-17 17:51:09] INFO source/source.c listener count on
> /different.ogg now 0
The listener disconnected.
> [2009-06-17 17:51:10] DBUG auth/auth.c max on /different.ogg is -1
> (cur 0)
> [2009-06-17 17:51:10] DBUG auth/auth.c Added client to /different.ogg
> [2009-06-17 17:51:10] DBUG auth/auth.c client authenticated, passed
> to source
> [2009-06-17 17:51:10] DBUG stats/stats.c update node clients (1)
> [2009-06-17 17:51:10] DBUG stats/stats.c update node listeners (0)
> [2009-06-17 17:51:10] DBUG stats/stats.c update node clients (2)
> [2009-06-17 17:51:10] DBUG stats/stats.c update node connections (5)
> [2009-06-17 17:51:10] DBUG stats/stats.c update node
> client_connections (4)
> [2009-06-17 17:51:10] DBUG stats/stats.c update node
> listener_connections (2)
> [2009-06-17 17:51:10] DBUG source/source.c Client added
> [2009-06-17 17:51:10] INFO source/source.c listener count on
> /different.ogg now 1
A new listener has connected.
> [2009-06-17 17:51:48] DBUG client/client.c Client connection died
> [2009-06-17 17:51:48] DBUG source/source.c Client removed
> [2009-06-17 17:51:48] INFO source/source.c listener count on
> /different.ogg now 0
And someone disconnects
and so on...
> [2009-06-17 17:52:05] DBUG slave/slave.c checking master stream list
> [2009-06-17 17:52:06] DBUG format-vorbis/format_vorbis.c adding EOS
> packet
> [2009-06-17 17:52:06] DBUG format-vorbis/format_vorbis.c flushing page
> [2009-06-17 17:52:06] DBUG format-ogg/format_ogg.c releasing header pages
> [2009-06-17 17:52:06] DBUG format-ogg/format_ogg.c releasing header pages
> [2009-06-17 17:52:06] DBUG format-ogg/format_ogg.c freeing codecs
> [2009-06-17 17:52:06] DBUG format-vorbis/format_vorbis.c freeing
> vorbis codec
> [2009-06-17 17:52:06] DBUG format-vorbis/format_vorbis.c checking for
> vorbis codec
> [2009-06-17 17:52:06] INFO format-vorbis/format_vorbis.c seen initial
> vorbis header
> [2009-06-17 17:52:06] DBUG format-vorbis/format_vorbis.c processing
> incoming header packet (1)
> [2009-06-17 17:52:06] DBUG format-vorbis/format_vorbis.c processing
> incoming header packet (2)
> [2009-06-17 17:52:06] DBUG format-vorbis/format_vorbis.c we have the
> header packets now
> [2009-06-17 17:52:06] DBUG format-vorbis/format_vorbis.c Adding the 3
> header packets
> [2009-06-17 17:52:06] DBUG format-ogg/format_ogg.c attaching BOS page
> [2009-06-17 17:52:06] DBUG format-ogg/format_ogg.c attaching header page
> [2009-06-17 17:52:06] DBUG stats/stats.c delete node audio_bitrate
> [2009-06-17 17:52:06] DBUG stats/stats.c delete node audio_channels
> [2009-06-17 17:52:06] DBUG stats/stats.c delete node audio_samplerate
> [2009-06-17 17:52:06] DBUG stats/stats.c new node audio_samplerate
> (44100)
> [2009-06-17 17:52:06] DBUG stats/stats.c new node audio_channels (2)
> [2009-06-17 17:52:06] DBUG stats/stats.c new node audio_bitrate (64001)
> [2009-06-17 17:52:06] DBUG stats/stats.c update node ice-bitrate (64)
> [2009-06-17 17:52:07] DBUG stats/stats.c update node artist (Gowan)
> [2009-06-17 17:52:07] DBUG stats/stats.c update node title (A
> Criminal Mind)
> [2009-06-17 17:52:07] DBUG stats/stats.c update node subtype (Vorbis)
> [2009-06-17 17:52:07] DBUG stats/stats.c update node clients (3)
> [2009-06-17 17:52:07] DBUG stats/stats.c update node connections (7)
> [2009-06-17 17:52:07] DBUG stats/stats.c update node
> client_connections (6)
> [2009-06-17 17:52:07] DBUG stats/stats.c update node clients (2)
The song changes
> [2009-06-17 17:52:47] INFO source/source.c End of Stream /different.ogg
> [2009-06-17 17:52:47] INFO source/source.c Source "/different.ogg"
> exiting
> [2009-06-17 17:52:47] DBUG source/source.c clearing source
> "/different.ogg"
> [2009-06-17 17:52:47] DBUG format-ogg/format_ogg.c releasing header pages
> [2009-06-17 17:52:47] DBUG format-ogg/format_ogg.c freeing codecs
> [2009-06-17 17:52:47] DBUG format-vorbis/format_vorbis.c freeing
> vorbis codec
> [2009-06-17 17:52:47] DBUG source/source.c freeing source
> "/different.ogg"
> [2009-06-17 17:52:47] DBUG stats/stats.c delete source node
> /different.ogg
> [2009-06-17 17:52:47] DBUG stats/stats.c update node clients (1)
> [2009-06-17 17:52:47] DBUG stats/stats.c update node clients (0)
> [2009-06-17 17:52:47] DBUG stats/stats.c update node sources (0)
Source client disconnected cleanly.
> access.log
>
> 216.82.22.78 - - [17/Jun/2009:17:50:07 -0700] "GET
> /different.ogg/7.html HTTP/1.0" 404 106 "-" "XML Getter (Mozilla
> Compatible)" 1
> 216.82.22.78 - - [17/Jun/2009:17:51:07 -0700] "GET
> /different.ogg/7.html HTTP/1.0" 404 106 "-" "XML Getter (Mozilla
> Compatible)" 0
the connections are comming from a lindenlab IP. I suppose it is
something weird related to second-life.
> 24.83.23.157 - - [17/Jun/2009:17:51:09 -0700] "GET /different.ogg
> HTTP/1.1" 200 303484 "-" "FMOD/3.74" 32
> 24.83.23.157 - - [17/Jun/2009:17:51:48 -0700] "GET /different.ogg
> HTTP/1.1" 200 355456 "-" "FMOD/3.74" 39
Listener connections, as noted above. Interestingly also mentioning your
own IP.
> 216.82.22.78 - - [17/Jun/2009:17:52:07 -0700] "GET
> /different.ogg/7.html HTTP/1.0" 404 106 "-" "XML Getter (Mozilla
> Compatible)" 0
SL again
> 24.83.23.157 - - [17/Jun/2009:17:52:47 -0700] "SOURCE /different.ogg
> ICE/1.0" 200 19 "-" "-" 158
The source client connection (please note that all the timestamps are
when DISCONNECT happens!). It was connected for 158 seconds.
> 24.83.23.157 - - [17/Jun/2009:17:52:47 -0700] "GET /different.ogg
> HTTP/1.1" 200 455892 "-" "FMOD/3.74" 58
Yet another listener connection
> 216.82.22.78 - - [17/Jun/2009:17:53:07 -0700] "GET
> /different.ogg/7.html HTTP/1.0" 404 106 "-" "XML Getter (Mozilla
> Compatible)" 0
> 216.82.22.78 - - [17/Jun/2009:17:54:07 -0700] "GET
> /different.ogg/7.html HTTP/1.0" 404 106 "-" "XML Getter (Mozilla
> Compatible)" 0
SL is trying to get that weird stuff again.
> icecase.xml
<snip > looks fine. a very minimalistic config with no explicit mount
definition.
Conclusion:
You have a working setup.
Some second life server requests inexistent URLs.
Your stream was up and running and served to a listener client.
Thomas
More information about the Icecast
mailing list