Icecast Streaming Media Server :: View topic - Need help looking at logs after drop out

Icecast Streaming Media Server
Icecast is a Xiph Foundation Project

FAQ

Memberlist

Usergroups

Profile

Need help looking at logs after drop out

Icecast Streaming Media Server Forum Index -> Icecast Server

View previous topic :: View next topic

Author

Message

square_eyes

Joined: 18 Oct 2011
Posts: 83

Posted: Fri Apr 19, 2013 1:51 pm Post subject: Need help looking at logs after drop out

My station just dropped out. Can anyone shed any light?

I have a source client (SAM broadcaster) streaming to a stage server, my master server is relaying a single mount point from that, which is password protected.

Further info, was that I was looking directly at SAM broadcaster, which still showed its encoders streaming, leading to beleive my stage server was till online.

Let me know if I can supply any more information.

The below is from my master server. I'll try to get the stage server logs.

Code:

[2013-04-19 08:27:47] DBUG stats/modify_node_event update "global" banned_IPs (0)
[2013-04-19 08:27:47] DBUG stats/modify_node_event update "global" outgoing_kbitrate (388)
[2013-04-19 08:27:48] DBUG stats/modify_node_event update "global" banned_IPs (0)
[2013-04-19 08:27:48] DBUG stats/modify_node_event update "global" outgoing_kbitrate (335)
[2013-04-19 08:27:49] DBUG stats/modify_node_event update "global" banned_IPs (0)
[2013-04-19 08:27:49] DBUG stats/modify_node_event update "global" outgoing_kbitrate (295)
[2013-04-19 08:27:50] DBUG stats/modify_node_event update "global" clients (11)
[2013-04-19 08:27:50] DBUG stats/modify_node_event update "global" connections (100257)
[2013-04-19 08:27:50] DBUG client/worker_add_pending_clients Added 1 pending clients to 0xa81fe0
[2013-04-19 08:27:50] DBUG client/worker 0xa81fe0 now has 13 clients
[2013-04-19 08:27:50] DBUG stats/modify_node_event update "global" clients (12)
[2013-04-19 08:27:50] DBUG stats/modify_node_event update "global" connections (100258)
[2013-04-19 08:27:50] DBUG client/worker_add_pending_clients Added 1 pending clients to 0xa81fe0
[2013-04-19 08:27:50] DBUG client/worker 0xa81fe0 now has 14 clients
[2013-04-19 08:27:50] DBUG connection/_handle_get_request start with /admin/stats.xml
[2013-04-19 08:27:50] DBUG stats/modify_node_event update "global" client_connections (100149)
[2013-04-19 08:27:50] INFO admin/admin_handle_general_request processing file stats.xml
[2013-04-19 08:27:50] DBUG stats/modify_node_event update "global" clients (11)
[2013-04-19 08:27:50] DBUG client/worker 0xa81fe0 now has 13 clients
[2013-04-19 08:27:50] DBUG connection/_handle_get_request start with /admin/stats.xml
[2013-04-19 08:27:50] DBUG stats/modify_node_event update "global" client_connections (100150)
[2013-04-19 08:27:50] INFO admin/admin_handle_general_request processing file stats.xml
[2013-04-19 08:27:50] DBUG stats/modify_node_event update "global" clients (10)
[2013-04-19 08:27:50] DBUG client/worker 0xa81fe0 now has 12 clients
[2013-04-19 08:27:50] DBUG stats/modify_node_event update "global" banned_IPs (0)
[2013-04-19 08:27:50] DBUG stats/modify_node_event update "global" outgoing_kbitrate (137)
[2013-04-19 08:27:51] DBUG stats/modify_node_event update "global" banned_IPs (0)
[2013-04-19 08:27:51] DBUG stats/modify_node_event update "global" outgoing_kbitrate (33)
[2013-04-19 08:27:52] DBUG stats/modify_node_event update "/autodj" outgoing_kbitrate (98)
[2013-04-19 08:27:52] DBUG stats/modify_node_event update "/autodj" incoming_bitrate (127128)
[2013-04-19 08:27:52] DBUG stats/modify_node_event update "/autodj" total_bytes_read (2881615457)
[2013-04-19 08:27:52] DBUG stats/modify_node_event update "/autodj" total_bytes_sent (31189050368)
[2013-04-19 08:27:52] DBUG stats/modify_node_event update "/autodj" total_mbytes_sent (29744)
[2013-04-19 08:27:52] DBUG stats/modify_node_event update "/autodj" queue_size (65202)
[2013-04-19 08:27:52] DBUG stats/modify_node_event update "/autodj" connected (180396)
[2013-04-19 08:27:52] DBUG stats/modify_node_event update "global" banned_IPs (0)
[2013-04-19 08:27:52] DBUG stats/modify_node_event update "global" outgoing_kbitrate (19)
[2013-04-19 08:27:53] DBUG stats/modify_node_event update "global" banned_IPs (0)
[2013-04-19 08:27:53] DBUG stats/modify_node_event update "global" banned_IPs (0)
[2013-04-19 08:27:53] DBUG stats/modify_node_event update "global" outgoing_kbitrate (13)
[2013-04-19 08:27:54] DBUG source/source_read last 1366378063, timeout 10, now 1366378074
[2013-04-19 08:27:54] WARN source/source_read Disconnecting /autodj due to socket timeout
[2013-04-19 08:27:54] DBUG source/send_listener source not running, listener will wait
[2013-04-19 08:27:54] DBUG source/send_listener source not running, listener will wait
[2013-04-19 08:27:54] DBUG source/send_listener source not running, listener will wait
[2013-04-19 08:27:54] DBUG source/send_listener source not running, listener will wait
[2013-04-19 08:27:54] DBUG source/send_listener source not running, listener will wait
[2013-04-19 08:27:54] DBUG source/send_listener source not running, listener will wait
[2013-04-19 08:27:54] DBUG source/send_listener source not running, listener will wait
[2013-04-19 08:27:54] DBUG source/send_listener source not running, listener will wait
[2013-04-19 08:27:54] DBUG source/send_listener source not running, listener will wait
[2013-04-19 08:27:54] DBUG source/source_clear_source clearing source "/autodj"
[2013-04-19 08:27:54] INFO slave/relay_reset servers to be retried on /autodj
[2013-04-19 08:27:54] WARN slave/relay_read stream for /autodj timed out, skipping server for now
[2013-04-19 08:27:54] INFO source/source_shutdown Source "/autodj" exiting
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "/autodj" outgoing_kbitrate (0)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "/autodj" incoming_bitrate (0)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "/autodj" total_bytes_read (0)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "/autodj" total_bytes_sent (0)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "/autodj" total_mbytes_sent (0)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "/autodj" queue_size (0)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "/autodj" connected (180398)
[2013-04-19 08:27:54] DBUG slave/relay_read counts are 9 and 9 (/autodj)
[2013-04-19 08:27:54] DBUG slave/relay_read all listeners have now been checked on /autodj
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" sources (0)
[2013-04-19 08:27:54] INFO slave/relay_read standing by to restart relay on /autodj
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "/autodj" listeners (9)
[2013-04-19 08:27:54] DBUG stats/_free_source_stats delete source node /autodj
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" sources (1)
[2013-04-19 08:27:54] INFO slave/start_relay_stream Starting relayed source at mountpoint "/autodj"
[2013-04-19 08:27:54] INFO slave/open_relay skipping budgiecollective.dyndns.org:8456 for /autodj
[2013-04-19 08:27:54] DBUG yp/yp_remove release /autodj on YP http://dir.xiph.org/cgi-bin/yp-cgi
[2013-04-19 08:27:54] INFO slave/start_relay_stream listener count remaining on /autodj is 9
[2013-04-19 08:27:54] WARN slave/relay_read stream for /autodj died too quickly, skipping server for now
[2013-04-19 08:27:54] INFO source/source_shutdown Source "/autodj" exiting
[2013-04-19 08:27:54] DBUG stats/stats_handle new source stat /autodj
[2013-04-19 08:27:54] DBUG stats/process_source_stat new node on /autodj "outgoing_kbitrate" (0)
[2013-04-19 08:27:54] DBUG stats/process_source_stat new node on /autodj "incoming_bitrate" (0)
[2013-04-19 08:27:54] DBUG stats/process_source_stat new node on /autodj "total_bytes_read" (0)
[2013-04-19 08:27:54] DBUG stats/process_source_stat new node on /autodj "total_bytes_sent" (0)
[2013-04-19 08:27:54] DBUG stats/process_source_stat new node on /autodj "total_mbytes_sent" (0)
[2013-04-19 08:27:54] DBUG stats/process_source_stat new node on /autodj "queue_size" (0)
[2013-04-19 08:27:54] DBUG stats/process_source_stat new node on /autodj "connected" (0)
[2013-04-19 08:27:54] INFO source/source_set_fallback fallback set on /autodj to /sounds/fallbackfile.mp3(0) with 9 listeners
[2013-04-19 08:27:54] DBUG slave/relay_read counts are 9 and 9 (/autodj)
[2013-04-19 08:27:54] DBUG slave/relay_read counts are 9 and 9 (/autodj)
[2013-04-19 08:27:54] DBUG slave/relay_read counts are 9 and 9 (/autodj)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" listeners (8)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (9)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" listeners (7)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (8)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" listeners (6)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (7)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" listeners (5)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (6)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" listeners (4)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (5)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" listeners (3)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (4)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" listeners (2)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (3)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" listeners (1)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (2)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" listeners (0)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (1)
[2013-04-19 08:27:54] DBUG client/worker 0xa81fe0 now has 3 clients
[2013-04-19 08:27:54] DBUG stats/_free_source_stats delete source node /live
[2013-04-19 08:27:54] DBUG stats/_free_source_stats delete source node /stream
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" banned_IPs (0)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" outgoing_kbitrate (0)
[2013-04-19 08:27:54] DBUG slave/relay_read all listeners have now been checked on /autodj
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" sources (0)
[2013-04-19 08:27:54] INFO slave/relay_read standing by to restart relay on /autodj in 120 seconds
[2013-04-19 08:27:54] DBUG source/source_clear_source clearing source "/autodj"
[2013-04-19 08:27:54] INFO slave/relay_reset servers to be retried on /autodj
[2013-04-19 08:27:54] DBUG stats/process_source_stat new node on /autodj "listeners" (0)
[2013-04-19 08:27:54] DBUG stats/_free_source_stats delete source node /autodj
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (2)
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" connections (100259)
[2013-04-19 08:27:54] DBUG client/worker_add_pending_clients Added 1 pending clients to 0xa81fe0
[2013-04-19 08:27:54] DBUG client/worker 0xa81fe0 now has 4 clients
[2013-04-19 08:27:54] DBUG connection/_handle_get_request start with /stream
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" client_connections (100151)
[2013-04-19 08:27:54] DBUG fserve/fserve_client_create checking for file /stream (web//stream)
[2013-04-19 08:27:54] WARN fserve/fserve_client_create req for file "web//stream" No such file or directory
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (1)
[2013-04-19 08:27:54] DBUG client/worker 0xa81fe0 now has 3 clients
[2013-04-19 08:27:54] INFO yp/do_yp_remove clearing up YP entry for /autodj
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" clients (2)
[2013-04-19 08:27:54] DBUG client/worker_add_pending_clients Added 1 pending clients to 0xa81fe0
[2013-04-19 08:27:54] DBUG client/worker 0xa81fe0 now has 4 clients
[2013-04-19 08:27:54] DBUG stats/modify_node_event update "global" connections (100260)
[2013-04-19 08:27:55] DBUG yp/send_to_yp YP remove at http://dir.xiph.org/cgi-bin/yp-cgi succeeded
[2013-04-19 08:27:55] DBUG yp/delete_marked_yp removed /autodj from YP server http://dir.xiph.org/cgi-bin/yp-cgi
[2013-04-19 08:27:55] DBUG connection/_handle_get_request start with /stream
[2013-04-19 08:27:55] DBUG stats/modify_node_event update "global" client_connections (100152)
[2013-04-19 08:27:55] DBUG fserve/fserve_client_create checking for file /stream (web//stream)
[2013-04-19 08:27:55] WARN fserve/fserve_client_create req for file "web//stream" No such file or directory
[2013-04-19 08:27:55] DBUG stats/modify_node_event update "global" clients (1)
[2013-04-19 08:27:55] DBUG client/worker 0xa81fe0 now has 3 clients
[2013-04-19 08:27:55] DBUG stats/modify_node_event update "global" banned_IPs (0)
[2013-04-19 08:27:55] DBUG stats/modify_node_event update "global" outgoing_kbitrate (1)
[2013-04-19 08:27:55] DBUG stats/modify_node_event update "global" clients (2)
[2013-04-19 08:27:55] DBUG stats/modify_node_event update "global" connections (100261)
[2013-04-19 08:27:55] DBUG client/worker_add_pending_clients Added 1 pending clients to 0xa81fe0
[2013-04-19 08:27:55] DBUG client/worker 0xa81fe0 now has 4 clients
[2013-04-19 08:27:56] DBUG connection/_handle_get_request start with /stream
[2013-04-19 08:27:56] DBUG stats/modify_node_event update "global" client_connections (100153)
[2013-04-19 08:27:56] DBUG fserve/fserve_client_create checking for file /stream (web//stream)
[2013-04-19 08:27:56] WARN fserve/fserve_client_create req for file "web//stream" No such file or directory
[2013-04-19 08:27:56] DBUG stats/modify_node_event update "global" clients (1)
[2013-04-19 08:27:56] DBUG client/worker 0xa81fe0 now has 3 clients
[2013-04-19 08:27:56] DBUG stats/modify_node_event update "global" clients (2)
[2013-04-19 08:27:56] DBUG stats/modify_node_event update "global" connections (100262)
[2013-04-19 08:27:56] DBUG client/worker_add_pending_clients Added 1 pending clients to 0xa81fe0
[2013-04-19 08:27:56] DBUG client/worker 0xa81fe0 now has 4 clients
[2013-04-19 08:27:56] DBUG connection/_handle_get_request start with /stream

square_eyes

Joined: 18 Oct 2011
Posts: 83

Posted: Fri Apr 19, 2013 2:10 pm Post subject:

Here are the logs from the stage server.

It looks like my source machine (SAM Broadcaster) had a drop in internet and disconnected. Am I right?

Code:

[2013-04-19 21:54:50] INFO admin/admin.c Metadata on mountpoint /autodj changed to "Andrew Slattery - Summertime Mixup IV"
[2013-04-19 23:27:54] WARN source/source.c Disconnecting source due to socket timeout
[2013-04-19 23:27:54] INFO source/source.c Source "/autodj" exiting
[2013-04-19 23:27:54] INFO source/source.c passing 1 listeners to "/fallback128StereoMP3_BCFailover.mp3"
[2013-04-19 23:27:54] INFO source/source.c listener count on /fallback128StereoMP3_BCFailover.mp3 now 1
[2013-04-19 23:27:54] WARN source/source.c unable to open file "C:/Data/Dropbox/IcecastServer/web/stream"
[2013-04-19 23:27:55] INFO source/source.c listener count on /fallback128StereoMP3_BCFailover.mp3 now 0
[2013-04-19 23:27:59] INFO connection/connection.c Source logging in at mountpoint "/autodj"
[2013-04-19 23:27:59] INFO source/source.c passing 0 listeners to "/autodj"
[2013-04-19 23:27:59] WARN source/source.c unable to open file "C:/Data/Dropbox/IcecastServer/web/stream"
[2013-04-19 23:27:59] INFO source/source.c listener count on /autodj now 0
[2013-04-19 23:29:22] INFO fserve/fserve.c checking for file /test (C:/Data/Dropbox/IcecastServer/web/test)
[2013-04-19 23:29:22] WARN fserve/fserve.c req for file "C:/Data/Dropbox/IcecastServer/web/test" No such file or directory
[2013-04-19 23:29:41] INFO connection/connection.c Source logging in at mountpoint "/autodj"
[2013-04-19 23:29:41] WARN connection/connection.c Mountpoint /autodj in use
[2013-04-19 23:29:48] INFO admin/admin.c Received admin command metadata on mount "/autodj"
[2013-04-19 23:29:48] INFO admin/admin.c Metadata on mountpoint /autodj changed to "1TrakMind - Live! @ Rock N' Run - Part 2"
[2013-04-19 23:29:53] INFO fserve/fserve.c checking for file /test (C:/Data/Dropbox/IcecastServer/web/test)
[2013-04-19 23:29:53] WARN fserve/fserve.c req for file "C:/Data/Dropbox/IcecastServer/web/test" No such file or directory
[2013-04-19 23:29:54] INFO auth/auth.c adding client for authentication
[2013-04-19 23:29:54] INFO auth/auth.c auth on /live has 1 pending
[2013-04-19 23:29:55] INFO source/source.c listener count on /autodj now 1
[2013-04-19 23:29:55] INFO admin/admin.c Received admin command metadata on mount "/autodj"
[2013-04-19 23:29:55] INFO admin/admin.c Metadata on mountpoint /autodj changed to "1TrakMind - Live! @ Rock N' Run - Part 2"
[2013-04-19 23:30:15] INFO connection/connection.c Source logging in at mountpoint "/autodj"
[2013-04-19 23:30:15] WARN connection/connection.c Mountpoint /autodj in use
[2013-04-19 23:30:50] INFO admin/admin.c Received admin command metadata on mount "/autodj"
[2013-04-19 23:30:50] INFO admin/admin.c Metadata on mountpoint /autodj changed to "Andrew Slattery - Summertime Mixup IV"
[2013-04-19 23:30:51] INFO connection/connection.c Source logging in at mountpoint "/autodj"
[2013-04-19 23:30:51] WARN connection/connection.c Mountpoint /autodj in use
[2013-04-19 23:31:26] INFO connection/connection.c Source logging in at mountpoint "/autodj"
[2013-04-19 23:31:26] WARN connection/connection.c Mountpoint /autodj in use
[2013-04-19 23:32:02] INFO connection/connection.c Source logging in at mountpoint "/autodj"
[2013-04-19 23:32:02] WARN connection/connection.c Mountpoint /autodj in use
[2013-04-19 23:32:37] INFO connection/connection.c Source logging in at mountpoint "/autodj"
[2013-04-19 23:32:37] WARN connection/connection.c Mountpoint /autodj in use
[2013-04-19 23:33:13] INFO connection/connection.c Source logging in at mountpoint "/autodj"
[2013-04-19 23:33:13] WARN connection/connection.c Mountpoint /autodj in use
[2013-04-19 23:33:48] INFO connection/connection.c Source logging in at mountpoint "/autodj"
[2013-04-19 23:33:48] WARN connection/connection.c Mountpoint /autodj in use
[2013-04-19 23:56:42] INFO admin/admin.c Received admin command metadata on mount "/autodj"
[2013-04-19 23:56:42] INFO admin/admin.c Metadata on mountpoint /autodj changed to "Paul Dubz - Deep Elements 014"
[2013-04-19 23:56:49] INFO admin/admin.c Received admin command metadata on mount "/autodj"
[2013-04-19 23:56:49] INFO admin/admin.c Metadata on mountpoint /autodj changed to "Paul Dubz - Deep Elements 014"

[/code]

karlH
Code Warrior

Joined: 13 Jun 2005
Posts: 5476
Location: UK

Posted: Sat Apr 20, 2013 11:30 am Post subject:

A source timeout trigger usually means an internet disconnection so it would look to be that. karl.

Display posts from previous:

	Icecast Streaming Media Server Forum Index -> Icecast Server	All times are GMT
Page 1 of 1

You cannot post new topics in this forum
You cannot reply to topics in this forum
You cannot edit your posts in this forum
You cannot delete your posts in this forum
You cannot vote in polls in this forum