Jun 10 07:01:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:01:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:01:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:01:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:01:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:01:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:01:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:02:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:02:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:39 squeezeplay: INFO squeezeplay - JiveMain.lua:207 Turn soft power on Jun 10 07:02:39 squeezeplay: WARN squeezebox.server - SlimServer.lua:606 wakeOnLan(): SKIPPING WOL, self.mac: nil, self:isSqueezeNetwork(): true Jun 10 07:02:39 squeezeplay: DEBUG net.comet - Comet.lua:464 Comet {mysqueezebox.com}: request(function: 0x748d60, reqid:23, 00:04:20:26:61:03, power,1,false,seq_no:5, priority:nil) Jun 10 07:02:39 squeezeplay: DEBUG net.comet - Comet.lua:356 Sending pending request(s): Jun 10 07:02:39 squeezeplay: DEBUG net.comet - Comet.lua:367 caching chttp ip address: 89.202.121.131 for: http://baby.squeezenetwork.com:9000/cometd Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:139 SocketHttp {mysqueezebox.com_Request} queuing table: 0x8673b0 - 1 requests in queue Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:193 SocketHttp {mysqueezebox.com_Request}:t_sendDequeueIfIdle state=t_sendDequeue Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, nil) Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:178 SocketHttp {mysqueezebox.com_Request}:t_sendDequeue() Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:183 SocketHttp {mysqueezebox.com_Request} send processing table: 0x8673b0 Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendResolve) Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:204 SocketHttp {mysqueezebox.com_Request}:t_sendResolve() Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:207 Using cached ip address: 89.202.121.131 for: baby.squeezenetwork.com Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendConnect) Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:249 SocketHttp {mysqueezebox.com_Request}:t_sendConnect() Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendRequest) Jun 10 07:02:39 squeezeplay: DEBUG net.http - SocketHttp.lua:341 SocketHttp {mysqueezebox.com_Request}:t_sendRequest() Jun 10 07:02:39 squeezeplay: DEBUG net.comet - Comet.lua:464 Comet {mysqueezebox.com}: request(function: 0x7b2fc8, reqid:24, 00:04:20:26:61:03, button,preset_1.single, priority:nil) Jun 10 07:02:39 squeezeplay: DEBUG net.comet - Comet.lua:356 Sending pending request(s): Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:367 caching chttp ip address: 89.202.121.131 for: http://baby.squeezenetwork.com:9000/cometd Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:139 SocketHttp {mysqueezebox.com_Request} queuing table: 0xca4e78 - 1 requests in queue Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:193 SocketHttp {mysqueezebox.com_Request}:t_sendDequeueIfIdle state=t_sendRequest Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:98 SocketHttp:__init(baby.squeezenetwork.com, baby.squeezenetwork.com, 80) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:139 SocketHttp {baby.squeezenetwork.com} queuing RequestHttp {GET /public/imageproxy?w=320&h=320&f=&u=http%3A%2F%2Fwww%2Emysqueezebox%2Ecom%2Fstatic%2Fimages%2Ficons%2Fradio%2Epng} - 1 requests in queue Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:193 SocketHttp {baby.squeezenetwork.com}:t_sendDequeueIfIdle state=t_sendDequeue Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {baby.squeezenetwork.com}:t_nextSendState(true, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:178 SocketHttp {baby.squeezenetwork.com}:t_sendDequeue() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:183 SocketHttp {baby.squeezenetwork.com} send processing RequestHttp {GET /public/imageproxy?w=320&h=320&f=&u=http%3A%2F%2Fwww%2Emysqueezebox%2Ecom%2Fstatic%2Fimages%2Ficons%2Fradio%2Epng} Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {baby.squeezenetwork.com}:t_nextSendState(true, t_sendResolve) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:204 SocketHttp {baby.squeezenetwork.com}:t_sendResolve() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:370 SocketHttp {mysqueezebox.com_Request}:t_sendRequest.pump() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:268 SocketHttp {mysqueezebox.com_Request}:t_getSendHeaders() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:321 keep-open-non-blocking sink(399, nil, 0) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:326 keep-open-non-blocking sent - first is nil returning 399, nil Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendComplete) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendDequeue) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:178 SocketHttp {mysqueezebox.com_Request}:t_sendDequeue() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:183 SocketHttp {mysqueezebox.com_Request} send processing table: 0xca4e78 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendResolve) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:204 SocketHttp {mysqueezebox.com_Request}:t_sendResolve() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:207 Using cached ip address: 89.202.121.131 for: baby.squeezenetwork.com Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendConnect) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:249 SocketHttp {mysqueezebox.com_Request}:t_sendConnect() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendRequest) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:341 SocketHttp {mysqueezebox.com_Request}:t_sendRequest() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:439 SocketHttp {mysqueezebox.com_Request}:t_recvDequeue() queueLength=1 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:446 SocketHttp {mysqueezebox.com_Request} recv processing table: 0x8673b0 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_rcvHeaders) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:468 SocketHttp {mysqueezebox.com_Request}:t_rcvHeaders() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:370 SocketHttp {mysqueezebox.com_Request}:t_sendRequest.pump() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:268 SocketHttp {mysqueezebox.com_Request}:t_getSendHeaders() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:321 keep-open-non-blocking sink(397, nil, 0) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:326 keep-open-non-blocking sent - first is nil returning 397, nil Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendComplete) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendDequeue) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:178 SocketHttp {mysqueezebox.com_Request}:t_sendDequeue() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:222 SocketHttp {baby.squeezenetwork.com} DNS loopup for baby.squeezenetwork.com Jun 10 07:02:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=aude #6 Jun 10 07:02:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(2, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 201 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(201, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(201, nil, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(201, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 201 Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /slim/request id=23 OK Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/request id=23 OK Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/request|23 Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x748d60 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:492 SocketHttp {mysqueezebox.com_Request}:t_rcvHeaders.pump() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_rcvResponse) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Request}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(144, done) Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /slim/request id=23 OK Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:716 SocketHttp.jive-concat.sink: done 144 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:818 SocketHttp {mysqueezebox.com_Request}:t_rcvResponse.pump: done (done) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_recvComplete) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_recvDequeue) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:439 SocketHttp {mysqueezebox.com_Request}:t_recvDequeue() queueLength=1 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:446 SocketHttp {mysqueezebox.com_Request} recv processing table: 0xca4e78 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_rcvHeaders) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:468 SocketHttp {mysqueezebox.com_Request}:t_rcvHeaders() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:492 SocketHttp {mysqueezebox.com_Request}:t_rcvHeaders.pump() Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_rcvResponse) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Request}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(144, done) Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /slim/request id=24 OK Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:716 SocketHttp.jive-concat.sink: done 144 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:818 SocketHttp {mysqueezebox.com_Request}:t_rcvResponse.pump: done (done) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_recvComplete) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_recvDequeue) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:439 SocketHttp {mysqueezebox.com_Request}:t_recvDequeue() queueLength=0 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:452 SocketHttp {mysqueezebox.com_Request}: no request recv in queue Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 338 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(338, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(338, nil, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(338, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 338 Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:02:40 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:441 _menuSink(1) nil menuDirective: add isCurrentServer:true Jun 10 07:02:40 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:713 hiding any 'connecting to server' popup after menu response from current server, SlimServer {mysqueezebox.com} Jun 10 07:02:40 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerLoaded(LocalPlayer {Squeezebox Radio}) Jun 10 07:02:40 squeezeplay: INFO applet.AlarmSnooze - AlarmSnoozeApplet.lua:255 notify_playerLoaded(LocalPlayer {Squeezebox Radio}) Jun 10 07:02:40 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jun 10 07:02:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:02:40 squeezeplay: DEBUG audio.decode - Playback.lua:587 strm q Jun 10 07:02:40 squeezeplay: DEBUG audio.decode - Playback.lua:939 stopping local pause timer Jun 10 07:02:40 squeezeplay: DEBUG audio.decode - decode_stop:660 decode_stop Jun 10 07:02:40 squeezeplay: DEBUG audio.decode - decode_stop_handler:197 decode_stop_handler Jun 10 07:02:40 squeezeplay: DEBUG audio.decode - Playback.lua:488 flush streambuf Jun 10 07:02:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 374 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(374, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(374, nil, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(374, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 374 Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/displaystatus/00:04:20:26:61:03 id=7 OK Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/displaystatus/00:04:20:26:61:03 Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x906ca8 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 378 Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(378, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(378, nil, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(378, nil) Jun 10 07:02:40 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 378 Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/displaystatus/00:04:20:26:61:03 id=7 OK Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/displaystatus/00:04:20:26:61:03 Jun 10 07:02:40 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x906ca8 Jun 10 07:02:40 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerTitleStatus(LocalPlayer {Squeezebox Radio}, Getting stream info... Jun 10 07:02:40 squeezeplay: Zapraszamy do Trójki - PR 3 Polskie Radio 96.4, 30000) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 263 Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(263, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(263, nil, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(263, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 263 Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/displaystatus/00:04:20:26:61:03 id=7 OK Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/displaystatus/00:04:20:26:61:03 Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x906ca8 Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(2, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 201 Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(201, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(201, nil, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(201, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 201 Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /slim/request id=24 OK Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/request id=24 OK Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/request|24 Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x7b2fc8 Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 338 Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=audg #26 Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - Playback.lua:939 stopping local pause timer Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - Playback.lua:870 gainL, gainR: 13312 13312 Jun 10 07:02:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(338, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(338, nil, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #483 Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - Playback.lua:587 strm s Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - Playback.lua:488 flush streambuf Jun 10 07:02:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - decode_start:698 decode_start Jun 10 07:02:41 squeezeplay: INFO audio.decode - decode_start_handler:275 init decoder wma Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - decode_output_set_track_gain:582 Track gain 65536 Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - decode_output_set_track_gain:586 Track clip range 7fffffff 80000000 Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - decode_set_track_polarity_inversion:591 Polarity inversion 0 Jun 10 07:02:41 squeezeplay: INFO audio.decode - Playback.lua:440 connect 195.245.217.7:80 GET /program3 HTTP/1.0^M Jun 10 07:02:41 squeezeplay: INFO audio.decode - Playback.lua:443 GET /program3 HTTP/1.0^M Jun 10 07:02:41 squeezeplay: Accept: */*^M Jun 10 07:02:41 squeezeplay: User-Agent: NSPlayer/8.0.0.3802^M Jun 10 07:02:41 squeezeplay: Host: stream.polskieradio.pl^M Jun 10 07:02:41 squeezeplay: Pragma: xClientGUID={67c3f5e3-5f29-f656-7b17-dfd92b874237}^M Jun 10 07:02:41 squeezeplay: Pragma: no-cache,rate=1.0000000,stream-offset=0:0,max-duration=0^M Jun 10 07:02:41 squeezeplay: Pragma: stream-time=0^M Jun 10 07:02:41 squeezeplay: Pragma: request-context=2^M Jun 10 07:02:41 squeezeplay: Pragma: LinkBW=2147483647, AccelBW=1048576, AccelDuration=21000^M Jun 10 07:02:41 squeezeplay: Pragma: Speed=5.000^M Jun 10 07:02:41 squeezeplay: Pragma: xPlayStrm=1^M Jun 10 07:02:41 squeezeplay: Pragma: stream-switch-count=1^M Jun 10 07:02:41 squeezeplay: Pragma: stream-switch-entry=ffff:1:0 ^M Jun 10 07:02:41 squeezeplay: ^M Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - Playback.lua:153 source=stream Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - stream_connectL:454 streambuf connect 195.245.217.7:80 Jun 10 07:02:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(338, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 338 Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:02:41 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:441 _menuSink(1) nil menuDirective: add isCurrentServer:true Jun 10 07:02:41 squeezeplay: INFO applet.SlimMenus - SlimMenusApplet.lua:713 hiding any 'connecting to server' popup after menu response from current server, SlimServer {mysqueezebox.com} Jun 10 07:02:41 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerLoaded(LocalPlayer {Squeezebox Radio}) Jun 10 07:02:41 squeezeplay: INFO applet.AlarmSnooze - AlarmSnoozeApplet.lua:255 notify_playerLoaded(LocalPlayer {Squeezebox Radio}) Jun 10 07:02:41 squeezeplay: INFO applet.ChooseMusicSource - ChooseMusicSourceApplet.lua:543 Hiding popup, exists?: nil Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 1773 Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=audg #26 Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - Playback.lua:939 stopping local pause timer Jun 10 07:02:41 squeezeplay: DEBUG audio.decode - Playback.lua:870 gainL, gainR: 13312 13312 Jun 10 07:02:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(1773, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(1773, nil, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:02:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=RESP Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(1773, nil) Jun 10 07:02:41 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 1773 Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/playerstatus/00:04:20:26:61:03 id=6 OK Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/playerstatus/00:04:20:26:61:03 Jun 10 07:02:41 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9068a8 Jun 10 07:02:41 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerPower(LocalPlayer {Squeezebox Radio}, true) Jun 10 07:02:41 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:271 notify_playerPower(): true Jun 10 07:02:41 squeezeplay: INFO applet.SlimDiscovery - SlimDiscoveryApplet.lua:517 notify_playerPower: true Jun 10 07:02:41 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerModeChange(LocalPlayer {Squeezebox Radio}, play) Jun 10 07:02:41 squeezeplay: WARN applet.AlarmSnooze - AlarmSnoozeApplet.lua:292 notify_playerModeChange: player (LocalPlayer {Squeezebox Radio}) mode has been changed to play Jun 10 07:02:41 squeezeplay: WARN applet.AlarmSnooze - AlarmSnoozeApplet.lua:294 notify_playerModeChange: - audioState is 0 Jun 10 07:02:41 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerTrackChange(LocalPlayer {Squeezebox Radio}, Zapraszamy do Trójki Jun 10 07:02:41 squeezeplay: PR 3 Polskie Radio 96.4 - PR 3 Polskie Radio) Jun 10 07:02:42 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerPlaylistChange(LocalPlayer {Squeezebox Radio}) Jun 10 07:02:42 squeezeplay: DEBUG net.comet - Comet.lua:464 Comet {mysqueezebox.com}: request(function: 0x9bcd28, reqid:25, 00:04:20:26:61:03, status,0,200,menu:menu,useContextMenu:1, priority:nil) Jun 10 07:02:42 squeezeplay: DEBUG net.comet - Comet.lua:356 Sending pending request(s): Jun 10 07:02:42 squeezeplay: DEBUG net.comet - Comet.lua:367 caching chttp ip address: 89.202.121.131 for: http://baby.squeezenetwork.com:9000/cometd Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:139 SocketHttp {mysqueezebox.com_Request} queuing table: 0xda5908 - 1 requests in queue Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:193 SocketHttp {mysqueezebox.com_Request}:t_sendDequeueIfIdle state=t_sendDequeue Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:178 SocketHttp {mysqueezebox.com_Request}:t_sendDequeue() Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:183 SocketHttp {mysqueezebox.com_Request} send processing table: 0xda5908 Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendResolve) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:204 SocketHttp {mysqueezebox.com_Request}:t_sendResolve() Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:207 Using cached ip address: 89.202.121.131 for: baby.squeezenetwork.com Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendConnect) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:249 SocketHttp {mysqueezebox.com_Request}:t_sendConnect() Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendRequest) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:341 SocketHttp {mysqueezebox.com_Request}:t_sendRequest() Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:370 SocketHttp {mysqueezebox.com_Request}:t_sendRequest.pump() Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:268 SocketHttp {mysqueezebox.com_Request}:t_getSendHeaders() Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:321 keep-open-non-blocking sink(416, nil, 0) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:326 keep-open-non-blocking sent - first is nil returning 416, nil Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendComplete) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendDequeue) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:178 SocketHttp {mysqueezebox.com_Request}:t_sendDequeue() Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:439 SocketHttp {mysqueezebox.com_Request}:t_recvDequeue() queueLength=1 Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:446 SocketHttp {mysqueezebox.com_Request} recv processing table: 0xda5908 Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_rcvHeaders) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:468 SocketHttp {mysqueezebox.com_Request}:t_rcvHeaders() Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 285 Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(285, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(285, nil, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:02:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(285, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 285 Jun 10 07:02:42 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/displaystatus/00:04:20:26:61:03 id=7 OK Jun 10 07:02:42 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/displaystatus/00:04:20:26:61:03 Jun 10 07:02:42 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x906ca8 Jun 10 07:02:42 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerTitleStatus(LocalPlayer {Squeezebox Radio}, Connecting... Jun 10 07:02:42 squeezeplay: Trójka - Polskie Radio SA, 500) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 285 Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(285, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(285, nil, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:492 SocketHttp {mysqueezebox.com_Request}:t_rcvHeaders.pump() Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_rcvResponse) Jun 10 07:02:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:02:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(285, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 285 Jun 10 07:02:42 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/displaystatus/00:04:20:26:61:03 id=7 OK Jun 10 07:02:42 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/displaystatus/00:04:20:26:61:03 Jun 10 07:02:42 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x906ca8 Jun 10 07:02:42 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerTitleStatus(LocalPlayer {Squeezebox Radio}, Connecting... Jun 10 07:02:42 squeezeplay: Trójka - Polskie Radio SA, 500) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Request}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(144, done) Jun 10 07:02:42 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /slim/request id=25 OK Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:716 SocketHttp.jive-concat.sink: done 144 Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:818 SocketHttp {mysqueezebox.com_Request}:t_rcvResponse.pump: done (done) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_recvComplete) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_recvDequeue) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:439 SocketHttp {mysqueezebox.com_Request}:t_recvDequeue() queueLength=0 Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:452 SocketHttp {mysqueezebox.com_Request}: no request recv in queue Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 285 Jun 10 07:02:42 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:02:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(285, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(285, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:02:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(285, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 285 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/displaystatus/00:04:20:26:61:03 id=7 OK Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/displaystatus/00:04:20:26:61:03 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x906ca8 Jun 10 07:02:43 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerTitleStatus(LocalPlayer {Squeezebox Radio}, Connecting... Jun 10 07:02:43 squeezeplay: Trójka - Polskie Radio SA, 500) Jun 10 07:02:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=cont #27 Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - Playback.lua:741 cont loop=0 icy=0 Jun 10 07:02:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 285 Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(285, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(285, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(285, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 285 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/displaystatus/00:04:20:26:61:03 id=7 OK Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/displaystatus/00:04:20:26:61:03 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x906ca8 Jun 10 07:02:43 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerTitleStatus(LocalPlayer {Squeezebox Radio}, Connecting... Jun 10 07:02:43 squeezeplay: Trójka - Polskie Radio SA, 500) Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - Playback.lua:360 resume decoder, 134438 bytes buffered, decode threshold 2048 Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - decode_resume_decoder:573 decode_resume_decoder Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - decode_resume_decoder_handler:117 resume_decoder decode state: 1 audio state 0 Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - debug_fullness:107 fullness: 134438 / 0 | 4.27% / 0.00% Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - decode_output_samples:385 first buffer sample_rate=44100 Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 285 Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(285, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(285, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(285, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 285 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/displaystatus/00:04:20:26:61:03 id=7 OK Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/displaystatus/00:04:20:26:61:03 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x906ca8 Jun 10 07:02:43 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerTitleStatus(LocalPlayer {Squeezebox Radio}, Connecting... Jun 10 07:02:43 squeezeplay: Trójka - Polskie Radio SA, 500) Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - Playback.lua:387 resume audio bytesReceivedL=134438 outputTime=116 threshold=61440 Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - decode_resume_audio:594 decode_resume_audio start_jiffies=0 Jun 10 07:02:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:43 squeezeplay: INFO audio.decode - Playback.lua:411 4.0%/1.2% Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - decode_resume_audio_handler:133 decode_resume_audio_handler start_interval=0 Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - debug_fullness:107 fullness: 127120 / 42984 | 4.04% / 1.22% Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - decode_resume_audio_handler:149 resume_audio decode state: 1 audio state 40 Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 1805 Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(1805, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(1805, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(1805, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 1805 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /slim/request id=25 OK Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/request id=25 OK Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/request|25 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9bcd28 Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 1773 Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(1773, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(1773, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(1773, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 1773 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/playerstatus/00:04:20:26:61:03 id=6 OK Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/playerstatus/00:04:20:26:61:03 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9068a8 Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 285 Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(285, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(285, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(285, nil) Jun 10 07:02:43 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 285 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/displaystatus/00:04:20:26:61:03 id=7 OK Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/displaystatus/00:04:20:26:61:03 Jun 10 07:02:43 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x906ca8 Jun 10 07:02:43 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerTitleStatus(LocalPlayer {Squeezebox Radio}, Buffering 99% Jun 10 07:02:43 squeezeplay: Trójka - Polskie Radio SA, 500) Jun 10 07:02:43 squeezeplay: DEBUG audio.decode - Playback.lua:335 status TRACK STARTED (elapsed: 96) Jun 10 07:02:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 1759 Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(1759, nil) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(1759, nil, nil) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(1759, nil) Jun 10 07:02:44 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 1759 Jun 10 07:02:44 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/playerstatus/00:04:20:26:61:03 id=6 OK Jun 10 07:02:44 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/playerstatus/00:04:20:26:61:03 Jun 10 07:02:44 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9068a8 Jun 10 07:02:45 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:45 squeezeplay: INFO audio.decode - Playback.lua:411 3.8%/21.5% Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:232 SocketHttp {baby.squeezenetwork.com} IP=89.202.121.131 Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {baby.squeezenetwork.com}:t_nextSendState(true, t_sendConnect) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:249 SocketHttp {baby.squeezenetwork.com}:t_sendConnect() Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {baby.squeezenetwork.com}:t_nextSendState(true, t_sendRequest) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:341 SocketHttp {baby.squeezenetwork.com}:t_sendRequest() Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:370 SocketHttp {baby.squeezenetwork.com}:t_sendRequest.pump() Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:268 SocketHttp {baby.squeezenetwork.com}:t_getSendHeaders() Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:321 keep-open-non-blocking sink(236, nil, 0) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:326 keep-open-non-blocking sent - first is nil returning 236, nil Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {baby.squeezenetwork.com}:t_nextSendState(true, t_sendComplete) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {baby.squeezenetwork.com}:t_nextSendState(true, t_sendDequeue) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:178 SocketHttp {baby.squeezenetwork.com}:t_sendDequeue() Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {baby.squeezenetwork.com}:t_nextRecvState(true, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:439 SocketHttp {baby.squeezenetwork.com}:t_recvDequeue() queueLength=1 Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:446 SocketHttp {baby.squeezenetwork.com} recv processing RequestHttp {GET /public/imageproxy?w=320&h=320&f=&u=http%3A%2F%2Fwww%2Emysqueezebox%2Ecom%2Fstatic%2Fimages%2Ficons%2Fradio%2Epng} Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {baby.squeezenetwork.com}:t_nextRecvState(true, t_rcvHeaders) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:468 SocketHttp {baby.squeezenetwork.com}:t_rcvHeaders() Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:492 SocketHttp {baby.squeezenetwork.com}:t_rcvHeaders.pump() Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {baby.squeezenetwork.com}:t_nextRecvState(true, t_rcvResponse) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(nil, timeout) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(4096, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(4096, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(nil, timeout) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(4096, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(4096, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(4096, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(4096, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(4096, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(4096, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(4096, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(4096, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump(jive-by-length, nil) Jun 10 07:02:45 squeezeplay: DEBUG net.http - SocketHttp.lua:700 SocketHttp.jive-concat.sink(599, done) Jun 10 07:02:46 squeezeplay: DEBUG net.http - SocketHttp.lua:716 SocketHttp.jive-concat.sink: done 41559 Jun 10 07:02:46 squeezeplay: DEBUG net.http - SocketHttp.lua:818 SocketHttp {baby.squeezenetwork.com}:t_rcvResponse.pump: done (done) Jun 10 07:02:46 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {baby.squeezenetwork.com}:t_nextRecvState(true, t_recvComplete) Jun 10 07:02:46 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {baby.squeezenetwork.com}:t_nextRecvState(true, t_recvDequeue) Jun 10 07:02:46 squeezeplay: DEBUG net.http - SocketHttp.lua:439 SocketHttp {baby.squeezenetwork.com}:t_recvDequeue() queueLength=0 Jun 10 07:02:46 squeezeplay: DEBUG net.http - SocketHttp.lua:452 SocketHttp {baby.squeezenetwork.com}: no request recv in queue Jun 10 07:02:46 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:46 squeezeplay: INFO audio.decode - Playback.lua:411 3.6%/28.3% Jun 10 07:02:47 squeezeplay: INFO squeezeplay.applets - AppletManager.lua:708 store settings: Playback Jun 10 07:02:47 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:47 squeezeplay: INFO audio.decode - Playback.lua:411 3.5%/35.9% Jun 10 07:02:48 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:48 squeezeplay: INFO audio.decode - Playback.lua:411 3.4%/40.9% Jun 10 07:02:49 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:49 squeezeplay: INFO audio.decode - Playback.lua:411 3.3%/46.7% Jun 10 07:02:50 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:50 squeezeplay: INFO audio.decode - Playback.lua:411 3.2%/51.2% Jun 10 07:02:51 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:51 squeezeplay: INFO audio.decode - Playback.lua:411 3.1%/56.4% Jun 10 07:02:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:02:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:54 squeezeplay: INFO audio.decode - Playback.lua:411 2.4%/97.7% Jun 10 07:02:54 squeezeplay: DEBUG net.http - SocketHttp.lua:871 SocketHttp {baby.squeezenetwork.com} closing with err: idle close Jun 10 07:02:54 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {baby.squeezenetwork.com}:t_nextSendState(true, t_sendDequeue) Jun 10 07:02:54 squeezeplay: DEBUG net.http - SocketHttp.lua:178 SocketHttp {baby.squeezenetwork.com}:t_sendDequeue() Jun 10 07:02:54 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {baby.squeezenetwork.com}:t_nextRecvState(true, t_recvDequeue) Jun 10 07:02:54 squeezeplay: DEBUG net.http - SocketHttp.lua:439 SocketHttp {baby.squeezenetwork.com}:t_recvDequeue() queueLength=0 Jun 10 07:02:54 squeezeplay: DEBUG net.http - SocketHttp.lua:452 SocketHttp {baby.squeezenetwork.com}: no request recv in queue Jun 10 07:02:55 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:55 squeezeplay: INFO audio.decode - Playback.lua:411 2.5%/96.8% Jun 10 07:02:57 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:57 squeezeplay: INFO audio.decode - Playback.lua:411 2.5%/95.1% Jun 10 07:02:58 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:58 squeezeplay: INFO audio.decode - Playback.lua:411 2.5%/95.6% Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 434 Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(434, nil) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(434, nil, nil) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:02:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:02:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:02:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:02:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:02:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:02:58 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerPower(LocalPlayer {Squeezebox Radio}, false) Jun 10 07:02:58 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:271 notify_playerPower(): false Jun 10 07:02:58 squeezeplay: INFO applet.SlimDiscovery - SlimDiscoveryApplet.lua:517 notify_playerPower: false Jun 10 07:02:58 squeezeplay: INFO squeezeplay - JiveMain.lua:200 Turn soft power off Jun 10 07:02:58 squeezeplay: DEBUG audio.decode - decode_pause_audio:617 decode_pause_audio interval_ms=0 Jun 10 07:02:58 squeezeplay: DEBUG audio.decode - decode_pause_audio_handler:159 decode_pause_handler interval=0 Jun 10 07:02:58 squeezeplay: DEBUG audio.decode - decode_pause_audio_handler:174 pause_audio decode state: 1 audio state 0 Jun 10 07:02:58 squeezeplay: INFO applet.ScreenSavers - ScreenSaversApplet.lua:280 activating Clock screensaver Jun 10 07:02:59 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:02:59 squeezeplay: INFO audio.decode - Playback.lua:411 2.5%/98.2% Jun 10 07:03:00 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:00 squeezeplay: INFO audio.decode - Playback.lua:411 2.7%/98.2% Jun 10 07:03:01 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:01 squeezeplay: INFO audio.decode - Playback.lua:411 2.7%/98.2% Jun 10 07:03:02 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:02 squeezeplay: INFO audio.decode - Playback.lua:411 3.0%/98.2% Jun 10 07:03:03 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:03 squeezeplay: INFO audio.decode - Playback.lua:411 3.2%/98.2% Jun 10 07:03:04 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:04 squeezeplay: INFO audio.decode - Playback.lua:411 3.4%/98.2% Jun 10 07:03:05 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:05 squeezeplay: INFO audio.decode - Playback.lua:411 3.6%/98.2% Jun 10 07:03:06 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:06 squeezeplay: INFO audio.decode - Playback.lua:411 3.8%/98.2% Jun 10 07:03:07 squeezeplay: INFO squeezeplay.applets - AppletManager.lua:708 store settings: Playback Jun 10 07:03:07 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:07 squeezeplay: INFO audio.decode - Playback.lua:411 4.0%/98.2% Jun 10 07:03:08 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:08 squeezeplay: INFO audio.decode - Playback.lua:411 4.3%/98.2% Jun 10 07:03:09 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:09 squeezeplay: INFO audio.decode - Playback.lua:411 4.5%/98.2% Jun 10 07:03:10 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:10 squeezeplay: INFO audio.decode - Playback.lua:411 4.7%/98.2% Jun 10 07:03:11 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:11 squeezeplay: INFO audio.decode - Playback.lua:411 4.9%/98.2% Jun 10 07:03:12 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:12 squeezeplay: INFO audio.decode - Playback.lua:411 5.1%/98.2% Jun 10 07:03:13 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:13 squeezeplay: INFO audio.decode - Playback.lua:411 5.3%/98.2% Jun 10 07:03:15 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:15 squeezeplay: INFO audio.decode - Playback.lua:411 5.6%/98.2% Jun 10 07:03:16 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:16 squeezeplay: INFO audio.decode - Playback.lua:411 5.8%/98.2% Jun 10 07:03:17 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:17 squeezeplay: INFO audio.decode - Playback.lua:411 6.0%/98.2% Jun 10 07:03:18 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:18 squeezeplay: INFO audio.decode - Playback.lua:411 6.2%/98.2% Jun 10 07:03:19 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:19 squeezeplay: INFO audio.decode - Playback.lua:411 6.4%/98.2% Jun 10 07:03:20 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:20 squeezeplay: INFO audio.decode - Playback.lua:411 6.6%/98.2% Jun 10 07:03:21 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:21 squeezeplay: INFO audio.decode - Playback.lua:411 6.9%/98.2% Jun 10 07:03:22 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:22 squeezeplay: INFO audio.decode - Playback.lua:411 7.1%/98.2% Jun 10 07:03:23 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:23 squeezeplay: INFO audio.decode - Playback.lua:411 7.2%/98.2% Jun 10 07:03:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:03:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:24 squeezeplay: INFO audio.decode - Playback.lua:411 7.5%/98.2% Jun 10 07:03:25 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:25 squeezeplay: INFO audio.decode - Playback.lua:411 7.5%/98.2% Jun 10 07:03:26 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:26 squeezeplay: INFO audio.decode - Playback.lua:411 7.7%/98.2% Jun 10 07:03:27 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:27 squeezeplay: INFO audio.decode - Playback.lua:411 7.9%/98.2% Jun 10 07:03:28 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:28 squeezeplay: INFO audio.decode - Playback.lua:411 8.2%/98.2% Jun 10 07:03:29 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:29 squeezeplay: INFO audio.decode - Playback.lua:411 8.4%/98.2% Jun 10 07:03:30 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:30 squeezeplay: INFO audio.decode - Playback.lua:411 8.6%/98.2% Jun 10 07:03:32 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:32 squeezeplay: INFO audio.decode - Playback.lua:411 8.8%/98.2% Jun 10 07:03:33 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:33 squeezeplay: INFO audio.decode - Playback.lua:411 9.0%/98.2% Jun 10 07:03:34 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:34 squeezeplay: INFO audio.decode - Playback.lua:411 9.2%/98.2% Jun 10 07:03:35 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:35 squeezeplay: INFO audio.decode - Playback.lua:411 9.5%/98.2% Jun 10 07:03:36 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:36 squeezeplay: INFO audio.decode - Playback.lua:411 9.7%/98.2% Jun 10 07:03:37 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:37 squeezeplay: INFO audio.decode - Playback.lua:411 9.9%/98.2% Jun 10 07:03:38 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:38 squeezeplay: INFO audio.decode - Playback.lua:411 10.1%/98.2% Jun 10 07:03:39 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:39 squeezeplay: INFO audio.decode - Playback.lua:411 10.3%/98.2% Jun 10 07:03:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:40 squeezeplay: INFO audio.decode - Playback.lua:411 10.5%/98.2% Jun 10 07:03:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:41 squeezeplay: INFO audio.decode - Playback.lua:411 10.8%/98.2% Jun 10 07:03:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:42 squeezeplay: INFO audio.decode - Playback.lua:411 11.0%/98.2% Jun 10 07:03:43 squeezeplay: WARN net.thread - NetworkThread.lua:146 network thread timeout for Task(SocketHttp {mysqueezebox.com_Request}(R)) Jun 10 07:03:43 squeezeplay: DEBUG net.http - SocketHttp.lua:871 SocketHttp {mysqueezebox.com_Request} closing with err: idle close Jun 10 07:03:43 squeezeplay: DEBUG net.http - SocketHttp.lua:149 SocketHttp {mysqueezebox.com_Request}:t_nextSendState(true, t_sendDequeue) Jun 10 07:03:43 squeezeplay: DEBUG net.http - SocketHttp.lua:178 SocketHttp {mysqueezebox.com_Request}:t_sendDequeue() Jun 10 07:03:43 squeezeplay: DEBUG net.http - SocketHttp.lua:421 SocketHttp {mysqueezebox.com_Request}:t_nextRecvState(true, t_recvDequeue) Jun 10 07:03:43 squeezeplay: DEBUG net.http - SocketHttp.lua:439 SocketHttp {mysqueezebox.com_Request}:t_recvDequeue() queueLength=0 Jun 10 07:03:43 squeezeplay: DEBUG net.http - SocketHttp.lua:452 SocketHttp {mysqueezebox.com_Request}: no request recv in queue Jun 10 07:03:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:43 squeezeplay: INFO audio.decode - Playback.lua:411 11.2%/98.2% Jun 10 07:03:45 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:45 squeezeplay: INFO audio.decode - Playback.lua:411 11.4%/98.2% Jun 10 07:03:46 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:46 squeezeplay: INFO audio.decode - Playback.lua:411 11.6%/98.2% Jun 10 07:03:47 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:47 squeezeplay: INFO audio.decode - Playback.lua:411 11.8%/98.2% Jun 10 07:03:48 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:48 squeezeplay: INFO audio.decode - Playback.lua:411 12.1%/98.2% Jun 10 07:03:49 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:49 squeezeplay: INFO audio.decode - Playback.lua:411 12.3%/98.2% Jun 10 07:03:50 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:50 squeezeplay: INFO audio.decode - Playback.lua:411 12.5%/98.2% Jun 10 07:03:51 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:51 squeezeplay: INFO audio.decode - Playback.lua:411 12.7%/98.2% Jun 10 07:03:52 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:52 squeezeplay: INFO audio.decode - Playback.lua:411 12.9%/98.2% Jun 10 07:03:53 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:53 squeezeplay: INFO audio.decode - Playback.lua:411 13.0%/98.2% Jun 10 07:03:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:03:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:54 squeezeplay: INFO audio.decode - Playback.lua:411 13.2%/98.2% Jun 10 07:03:55 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:55 squeezeplay: INFO audio.decode - Playback.lua:411 13.4%/98.2% Jun 10 07:03:56 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:56 squeezeplay: INFO audio.decode - Playback.lua:411 13.6%/98.2% Jun 10 07:03:58 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:58 squeezeplay: INFO audio.decode - Playback.lua:411 13.8%/98.2% Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 434 Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(434, nil) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(434, nil, nil) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:03:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:03:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:03:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:03:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:03:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:03:58 squeezeplay: DEBUG net.thread - NetworkThread.lua:256 NOTIFY: playerPower(LocalPlayer {Squeezebox Radio}, true) Jun 10 07:03:58 squeezeplay: DEBUG applet.AlarmSnooze - AlarmSnoozeApplet.lua:271 notify_playerPower(): true Jun 10 07:03:58 squeezeplay: INFO applet.SlimDiscovery - SlimDiscoveryApplet.lua:517 notify_playerPower: true Jun 10 07:03:58 squeezeplay: INFO squeezeplay - JiveMain.lua:207 Turn soft power on Jun 10 07:03:58 squeezeplay: WARN squeezebox.server - SlimServer.lua:606 wakeOnLan(): SKIPPING WOL, self.mac: nil, self:isSqueezeNetwork(): true Jun 10 07:03:59 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:03:59 squeezeplay: INFO audio.decode - Playback.lua:411 14.0%/98.2% Jun 10 07:04:00 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:00 squeezeplay: INFO audio.decode - Playback.lua:411 14.2%/98.2% Jun 10 07:04:01 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:01 squeezeplay: INFO audio.decode - Playback.lua:411 14.4%/98.2% Jun 10 07:04:02 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:02 squeezeplay: INFO audio.decode - Playback.lua:411 14.6%/98.2% Jun 10 07:04:03 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:03 squeezeplay: INFO audio.decode - Playback.lua:411 14.9%/98.2% Jun 10 07:04:04 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:04 squeezeplay: INFO audio.decode - Playback.lua:411 15.1%/98.2% Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 339 Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(339, nil) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(339, nil, nil) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(339, nil) Jun 10 07:04:04 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 339 Jun 10 07:04:04 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:04:04 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:04:04 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:04:05 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:05 squeezeplay: INFO audio.decode - Playback.lua:411 15.3%/98.2% Jun 10 07:04:06 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:06 squeezeplay: INFO audio.decode - Playback.lua:411 15.5%/98.2% Jun 10 07:04:07 squeezeplay: INFO squeezeplay.applets - AppletManager.lua:708 store settings: Playback Jun 10 07:04:07 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:07 squeezeplay: INFO audio.decode - Playback.lua:411 15.7%/98.2% Jun 10 07:04:08 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:08 squeezeplay: INFO audio.decode - Playback.lua:411 15.9%/98.2% Jun 10 07:04:09 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:09 squeezeplay: INFO audio.decode - Playback.lua:411 16.2%/98.2% Jun 10 07:04:10 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:10 squeezeplay: INFO audio.decode - Playback.lua:411 16.4%/98.2% Jun 10 07:04:11 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:11 squeezeplay: INFO audio.decode - Playback.lua:411 16.6%/98.2% Jun 10 07:04:12 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:12 squeezeplay: INFO audio.decode - Playback.lua:411 16.8%/98.2% Jun 10 07:04:14 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:14 squeezeplay: INFO audio.decode - Playback.lua:411 17.0%/98.2% Jun 10 07:04:15 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:15 squeezeplay: INFO audio.decode - Playback.lua:411 17.2%/98.2% Jun 10 07:04:16 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:16 squeezeplay: INFO audio.decode - Playback.lua:411 17.5%/98.2% Jun 10 07:04:17 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:17 squeezeplay: INFO audio.decode - Playback.lua:411 17.7%/98.2% Jun 10 07:04:18 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:18 squeezeplay: INFO audio.decode - Playback.lua:411 17.9%/98.2% Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 328 Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(328, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(328, nil, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(328, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 328 Jun 10 07:04:18 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:04:18 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:04:18 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 328 Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(328, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(328, nil, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(328, nil) Jun 10 07:04:18 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 328 Jun 10 07:04:18 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:04:18 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:04:18 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:04:19 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:19 squeezeplay: INFO audio.decode - Playback.lua:411 18.1%/98.2% Jun 10 07:04:20 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:20 squeezeplay: INFO audio.decode - Playback.lua:411 18.2%/98.2% Jun 10 07:04:21 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:21 squeezeplay: INFO audio.decode - Playback.lua:411 18.3%/98.2% Jun 10 07:04:22 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:22 squeezeplay: INFO audio.decode - Playback.lua:411 18.5%/98.2% Jun 10 07:04:23 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:23 squeezeplay: INFO audio.decode - Playback.lua:411 18.8%/98.2% Jun 10 07:04:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:04:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:24 squeezeplay: INFO audio.decode - Playback.lua:411 19.0%/98.2% Jun 10 07:04:25 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:25 squeezeplay: INFO audio.decode - Playback.lua:411 19.2%/98.2% Jun 10 07:04:26 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:26 squeezeplay: INFO audio.decode - Playback.lua:411 19.4%/98.2% Jun 10 07:04:27 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:27 squeezeplay: INFO audio.decode - Playback.lua:411 19.6%/98.2% Jun 10 07:04:28 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:28 squeezeplay: INFO audio.decode - Playback.lua:411 19.8%/98.2% Jun 10 07:04:29 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:29 squeezeplay: INFO audio.decode - Playback.lua:411 20.1%/98.2% Jun 10 07:04:30 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:30 squeezeplay: INFO audio.decode - Playback.lua:411 20.3%/98.2% Jun 10 07:04:32 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:32 squeezeplay: INFO audio.decode - Playback.lua:411 20.5%/98.2% Jun 10 07:04:33 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:33 squeezeplay: INFO audio.decode - Playback.lua:411 20.7%/98.2% Jun 10 07:04:34 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:34 squeezeplay: INFO audio.decode - Playback.lua:411 20.9%/98.2% Jun 10 07:04:35 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:35 squeezeplay: INFO audio.decode - Playback.lua:411 21.1%/98.2% Jun 10 07:04:36 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:36 squeezeplay: INFO audio.decode - Playback.lua:411 21.4%/98.2% Jun 10 07:04:37 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:37 squeezeplay: INFO audio.decode - Playback.lua:411 21.6%/98.2% Jun 10 07:04:38 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:38 squeezeplay: INFO audio.decode - Playback.lua:411 21.8%/98.2% Jun 10 07:04:39 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:39 squeezeplay: INFO audio.decode - Playback.lua:411 22.0%/98.2% Jun 10 07:04:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:40 squeezeplay: INFO audio.decode - Playback.lua:411 22.2%/98.2% Jun 10 07:04:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:41 squeezeplay: INFO audio.decode - Playback.lua:411 22.4%/98.2% Jun 10 07:04:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:42 squeezeplay: INFO audio.decode - Playback.lua:411 22.5%/98.2% Jun 10 07:04:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:43 squeezeplay: INFO audio.decode - Playback.lua:411 22.8%/98.2% Jun 10 07:04:44 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:44 squeezeplay: INFO audio.decode - Playback.lua:411 22.9%/98.2% Jun 10 07:04:45 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:45 squeezeplay: INFO audio.decode - Playback.lua:411 23.1%/98.2% Jun 10 07:04:46 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:46 squeezeplay: INFO audio.decode - Playback.lua:411 23.3%/98.2% Jun 10 07:04:48 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:48 squeezeplay: INFO audio.decode - Playback.lua:411 23.5%/98.2% Jun 10 07:04:49 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:49 squeezeplay: INFO audio.decode - Playback.lua:411 23.7%/98.2% Jun 10 07:04:50 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:50 squeezeplay: INFO audio.decode - Playback.lua:411 24.0%/98.2% Jun 10 07:04:51 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:51 squeezeplay: INFO audio.decode - Playback.lua:411 24.2%/98.2% Jun 10 07:04:52 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:52 squeezeplay: INFO audio.decode - Playback.lua:411 24.4%/98.2% Jun 10 07:04:53 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:53 squeezeplay: INFO audio.decode - Playback.lua:411 24.6%/98.2% Jun 10 07:04:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:54 squeezeplay: INFO audio.decode - Playback.lua:411 24.8%/98.2% Jun 10 07:04:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:04:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:55 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:55 squeezeplay: INFO audio.decode - Playback.lua:411 25.0%/98.2% Jun 10 07:04:56 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:56 squeezeplay: INFO audio.decode - Playback.lua:411 25.3%/98.2% Jun 10 07:04:57 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:57 squeezeplay: INFO audio.decode - Playback.lua:411 25.5%/98.2% Jun 10 07:04:58 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:58 squeezeplay: INFO audio.decode - Playback.lua:411 25.7%/98.2% Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 434 Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(434, nil) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(434, nil, nil) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:04:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:04:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:04:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:04:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:04:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:04:59 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:04:59 squeezeplay: INFO audio.decode - Playback.lua:411 25.9%/98.2% Jun 10 07:05:00 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:00 squeezeplay: INFO audio.decode - Playback.lua:411 26.1%/98.2% Jun 10 07:05:01 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:01 squeezeplay: INFO audio.decode - Playback.lua:411 26.2%/98.2% Jun 10 07:05:02 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:02 squeezeplay: INFO audio.decode - Playback.lua:411 26.5%/98.2% Jun 10 07:05:03 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:03 squeezeplay: INFO audio.decode - Playback.lua:411 26.6%/98.2% Jun 10 07:05:04 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:04 squeezeplay: INFO audio.decode - Playback.lua:411 26.8%/98.2% Jun 10 07:05:06 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:06 squeezeplay: INFO audio.decode - Playback.lua:411 27.0%/98.2% Jun 10 07:05:07 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:07 squeezeplay: INFO audio.decode - Playback.lua:411 27.2%/98.2% Jun 10 07:05:08 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:08 squeezeplay: INFO audio.decode - Playback.lua:411 27.4%/98.2% Jun 10 07:05:09 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:09 squeezeplay: INFO audio.decode - Playback.lua:411 27.6%/98.2% Jun 10 07:05:10 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:10 squeezeplay: INFO audio.decode - Playback.lua:411 27.9%/98.2% Jun 10 07:05:11 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:11 squeezeplay: INFO audio.decode - Playback.lua:411 28.1%/98.2% Jun 10 07:05:12 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:12 squeezeplay: INFO audio.decode - Playback.lua:411 28.3%/98.2% Jun 10 07:05:13 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:13 squeezeplay: INFO audio.decode - Playback.lua:411 28.5%/98.2% Jun 10 07:05:14 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:14 squeezeplay: INFO audio.decode - Playback.lua:411 28.7%/98.2% Jun 10 07:05:15 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:15 squeezeplay: INFO audio.decode - Playback.lua:411 28.9%/98.2% Jun 10 07:05:16 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:16 squeezeplay: INFO audio.decode - Playback.lua:411 29.2%/98.2% Jun 10 07:05:17 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:17 squeezeplay: INFO audio.decode - Playback.lua:411 29.4%/98.2% Jun 10 07:05:18 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:18 squeezeplay: INFO audio.decode - Playback.lua:411 29.6%/98.2% Jun 10 07:05:19 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:19 squeezeplay: INFO audio.decode - Playback.lua:411 29.8%/98.2% Jun 10 07:05:20 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:20 squeezeplay: INFO audio.decode - Playback.lua:411 30.0%/98.2% Jun 10 07:05:21 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:21 squeezeplay: INFO audio.decode - Playback.lua:411 30.2%/98.2% Jun 10 07:05:23 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:23 squeezeplay: INFO audio.decode - Playback.lua:411 30.5%/98.2% Jun 10 07:05:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:24 squeezeplay: INFO audio.decode - Playback.lua:411 30.7%/98.2% Jun 10 07:05:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:05:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:25 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:25 squeezeplay: INFO audio.decode - Playback.lua:411 30.9%/98.2% Jun 10 07:05:26 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:26 squeezeplay: INFO audio.decode - Playback.lua:411 31.1%/98.2% Jun 10 07:05:27 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:27 squeezeplay: INFO audio.decode - Playback.lua:411 31.3%/98.2% Jun 10 07:05:28 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:28 squeezeplay: INFO audio.decode - Playback.lua:411 31.4%/98.2% Jun 10 07:05:29 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:29 squeezeplay: INFO audio.decode - Playback.lua:411 31.8%/98.2% Jun 10 07:05:30 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:30 squeezeplay: INFO audio.decode - Playback.lua:411 31.8%/98.2% Jun 10 07:05:31 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:31 squeezeplay: INFO audio.decode - Playback.lua:411 32.0%/98.2% Jun 10 07:05:32 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:32 squeezeplay: INFO audio.decode - Playback.lua:411 32.2%/98.2% Jun 10 07:05:33 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:33 squeezeplay: INFO audio.decode - Playback.lua:411 32.4%/98.2% Jun 10 07:05:34 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:34 squeezeplay: INFO audio.decode - Playback.lua:411 32.6%/98.2% Jun 10 07:05:35 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:35 squeezeplay: INFO audio.decode - Playback.lua:411 32.8%/98.2% Jun 10 07:05:37 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:37 squeezeplay: INFO audio.decode - Playback.lua:411 33.0%/98.2% Jun 10 07:05:38 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:38 squeezeplay: INFO audio.decode - Playback.lua:411 33.3%/98.2% Jun 10 07:05:39 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:39 squeezeplay: INFO audio.decode - Playback.lua:411 33.5%/98.2% Jun 10 07:05:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:40 squeezeplay: INFO audio.decode - Playback.lua:411 33.7%/98.2% Jun 10 07:05:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:41 squeezeplay: INFO audio.decode - Playback.lua:411 33.9%/98.2% Jun 10 07:05:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:42 squeezeplay: INFO audio.decode - Playback.lua:411 34.1%/98.2% Jun 10 07:05:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:43 squeezeplay: INFO audio.decode - Playback.lua:411 34.3%/98.2% Jun 10 07:05:44 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:44 squeezeplay: INFO audio.decode - Playback.lua:411 34.6%/98.2% Jun 10 07:05:45 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:45 squeezeplay: INFO audio.decode - Playback.lua:411 34.8%/98.2% Jun 10 07:05:46 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:46 squeezeplay: INFO audio.decode - Playback.lua:411 35.0%/98.2% Jun 10 07:05:47 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:47 squeezeplay: INFO audio.decode - Playback.lua:411 35.2%/98.2% Jun 10 07:05:49 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:49 squeezeplay: INFO audio.decode - Playback.lua:411 35.4%/98.2% Jun 10 07:05:50 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:50 squeezeplay: INFO audio.decode - Playback.lua:411 35.6%/98.2% Jun 10 07:05:51 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:51 squeezeplay: INFO audio.decode - Playback.lua:411 35.9%/98.2% Jun 10 07:05:52 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:52 squeezeplay: INFO audio.decode - Playback.lua:411 36.1%/98.2% Jun 10 07:05:53 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:53 squeezeplay: INFO audio.decode - Playback.lua:411 36.3%/98.2% Jun 10 07:05:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:54 squeezeplay: INFO audio.decode - Playback.lua:411 36.5%/98.2% Jun 10 07:05:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:05:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:55 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:55 squeezeplay: INFO audio.decode - Playback.lua:411 36.7%/98.2% Jun 10 07:05:56 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:56 squeezeplay: INFO audio.decode - Playback.lua:411 36.9%/98.2% Jun 10 07:05:57 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:57 squeezeplay: INFO audio.decode - Playback.lua:411 37.2%/98.2% Jun 10 07:05:58 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:58 squeezeplay: INFO audio.decode - Playback.lua:411 37.4%/98.2% Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 434 Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(434, nil) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(434, nil, nil) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:05:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:05:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:05:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:05:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:05:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:05:59 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:05:59 squeezeplay: INFO audio.decode - Playback.lua:411 37.6%/98.2% Jun 10 07:06:00 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:00 squeezeplay: INFO audio.decode - Playback.lua:411 37.7%/98.2% Jun 10 07:06:01 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:01 squeezeplay: INFO audio.decode - Playback.lua:411 38.0%/98.2% Jun 10 07:06:02 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:02 squeezeplay: INFO audio.decode - Playback.lua:411 38.0%/98.2% Jun 10 07:06:03 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:03 squeezeplay: INFO audio.decode - Playback.lua:411 38.2%/98.2% Jun 10 07:06:05 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:05 squeezeplay: INFO audio.decode - Playback.lua:411 38.5%/98.2% Jun 10 07:06:06 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:06 squeezeplay: INFO audio.decode - Playback.lua:411 38.7%/98.2% Jun 10 07:06:07 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:07 squeezeplay: INFO audio.decode - Playback.lua:411 38.9%/98.2% Jun 10 07:06:08 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:08 squeezeplay: INFO audio.decode - Playback.lua:411 39.1%/98.2% Jun 10 07:06:09 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:09 squeezeplay: INFO audio.decode - Playback.lua:411 39.3%/98.2% Jun 10 07:06:10 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:10 squeezeplay: INFO audio.decode - Playback.lua:411 39.5%/98.2% Jun 10 07:06:11 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:11 squeezeplay: INFO audio.decode - Playback.lua:411 39.8%/98.2% Jun 10 07:06:12 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:12 squeezeplay: INFO audio.decode - Playback.lua:411 40.0%/98.2% Jun 10 07:06:13 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:13 squeezeplay: INFO audio.decode - Playback.lua:411 40.2%/98.2% Jun 10 07:06:14 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:14 squeezeplay: INFO audio.decode - Playback.lua:411 40.4%/98.2% Jun 10 07:06:15 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:15 squeezeplay: INFO audio.decode - Playback.lua:411 40.6%/98.2% Jun 10 07:06:16 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:16 squeezeplay: INFO audio.decode - Playback.lua:411 40.8%/98.2% Jun 10 07:06:17 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:17 squeezeplay: INFO audio.decode - Playback.lua:411 41.1%/98.2% Jun 10 07:06:18 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:18 squeezeplay: INFO audio.decode - Playback.lua:411 41.3%/98.2% Jun 10 07:06:19 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:19 squeezeplay: INFO audio.decode - Playback.lua:411 41.5%/98.2% Jun 10 07:06:20 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:20 squeezeplay: INFO audio.decode - Playback.lua:411 41.7%/98.2% Jun 10 07:06:21 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:21 squeezeplay: INFO audio.decode - Playback.lua:411 41.9%/98.2% Jun 10 07:06:22 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:22 squeezeplay: INFO audio.decode - Playback.lua:411 42.0%/98.2% Jun 10 07:06:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:24 squeezeplay: INFO audio.decode - Playback.lua:411 42.2%/98.2% Jun 10 07:06:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:06:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:25 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:25 squeezeplay: INFO audio.decode - Playback.lua:411 42.4%/98.2% Jun 10 07:06:26 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:26 squeezeplay: INFO audio.decode - Playback.lua:411 42.6%/98.2% Jun 10 07:06:27 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:27 squeezeplay: INFO audio.decode - Playback.lua:411 42.8%/98.2% Jun 10 07:06:28 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:28 squeezeplay: INFO audio.decode - Playback.lua:411 43.0%/98.2% Jun 10 07:06:29 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:29 squeezeplay: INFO audio.decode - Playback.lua:411 43.2%/98.2% Jun 10 07:06:30 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:30 squeezeplay: INFO audio.decode - Playback.lua:411 43.4%/98.2% Jun 10 07:06:31 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:31 squeezeplay: INFO audio.decode - Playback.lua:411 43.7%/98.2% Jun 10 07:06:32 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:32 squeezeplay: INFO audio.decode - Playback.lua:411 43.9%/98.2% Jun 10 07:06:33 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:33 squeezeplay: INFO audio.decode - Playback.lua:411 44.1%/98.2% Jun 10 07:06:34 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:34 squeezeplay: INFO audio.decode - Playback.lua:411 44.3%/98.2% Jun 10 07:06:35 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:35 squeezeplay: INFO audio.decode - Playback.lua:411 44.5%/98.2% Jun 10 07:06:36 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:36 squeezeplay: INFO audio.decode - Playback.lua:411 44.7%/98.2% Jun 10 07:06:37 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:37 squeezeplay: INFO audio.decode - Playback.lua:411 45.0%/98.2% Jun 10 07:06:38 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:38 squeezeplay: INFO audio.decode - Playback.lua:411 45.2%/98.2% Jun 10 07:06:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:40 squeezeplay: INFO audio.decode - Playback.lua:411 45.4%/98.2% Jun 10 07:06:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:41 squeezeplay: INFO audio.decode - Playback.lua:411 45.6%/98.2% Jun 10 07:06:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:42 squeezeplay: INFO audio.decode - Playback.lua:411 45.8%/98.2% Jun 10 07:06:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:43 squeezeplay: INFO audio.decode - Playback.lua:411 46.0%/98.2% Jun 10 07:06:44 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:44 squeezeplay: INFO audio.decode - Playback.lua:411 46.3%/98.2% Jun 10 07:06:45 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:45 squeezeplay: INFO audio.decode - Playback.lua:411 46.5%/98.2% Jun 10 07:06:46 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:46 squeezeplay: INFO audio.decode - Playback.lua:411 46.7%/98.2% Jun 10 07:06:47 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:47 squeezeplay: INFO audio.decode - Playback.lua:411 46.9%/98.2% Jun 10 07:06:48 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:48 squeezeplay: INFO audio.decode - Playback.lua:411 47.1%/98.2% Jun 10 07:06:49 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:49 squeezeplay: INFO audio.decode - Playback.lua:411 47.2%/98.2% Jun 10 07:06:50 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:50 squeezeplay: INFO audio.decode - Playback.lua:411 47.3%/98.2% Jun 10 07:06:51 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:51 squeezeplay: INFO audio.decode - Playback.lua:411 47.6%/98.2% Jun 10 07:06:52 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:52 squeezeplay: INFO audio.decode - Playback.lua:411 47.8%/98.2% Jun 10 07:06:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:54 squeezeplay: INFO audio.decode - Playback.lua:411 48.0%/98.2% Jun 10 07:06:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:06:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:55 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:55 squeezeplay: INFO audio.decode - Playback.lua:411 48.2%/98.2% Jun 10 07:06:56 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:56 squeezeplay: INFO audio.decode - Playback.lua:411 48.4%/98.2% Jun 10 07:06:57 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:57 squeezeplay: INFO audio.decode - Playback.lua:411 48.6%/98.2% Jun 10 07:06:58 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:58 squeezeplay: INFO audio.decode - Playback.lua:411 48.9%/98.2% Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 434 Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(434, nil) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(434, nil, nil) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:06:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:06:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:06:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:06:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:06:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:06:59 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:06:59 squeezeplay: INFO audio.decode - Playback.lua:411 49.1%/98.2% Jun 10 07:07:00 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:00 squeezeplay: INFO audio.decode - Playback.lua:411 49.3%/98.2% Jun 10 07:07:01 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:01 squeezeplay: INFO audio.decode - Playback.lua:411 49.5%/98.2% Jun 10 07:07:02 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:02 squeezeplay: INFO audio.decode - Playback.lua:411 49.7%/98.2% Jun 10 07:07:03 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:03 squeezeplay: INFO audio.decode - Playback.lua:411 49.9%/98.2% Jun 10 07:07:04 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:04 squeezeplay: INFO audio.decode - Playback.lua:411 50.2%/98.2% Jun 10 07:07:05 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:05 squeezeplay: INFO audio.decode - Playback.lua:411 50.4%/98.2% Jun 10 07:07:06 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:06 squeezeplay: INFO audio.decode - Playback.lua:411 50.6%/98.2% Jun 10 07:07:07 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:07 squeezeplay: INFO audio.decode - Playback.lua:411 50.8%/98.2% Jun 10 07:07:08 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:08 squeezeplay: INFO audio.decode - Playback.lua:411 51.0%/98.2% Jun 10 07:07:10 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:10 squeezeplay: INFO audio.decode - Playback.lua:411 51.2%/98.2% Jun 10 07:07:11 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:11 squeezeplay: INFO audio.decode - Playback.lua:411 51.5%/98.2% Jun 10 07:07:12 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:12 squeezeplay: INFO audio.decode - Playback.lua:411 51.7%/98.2% Jun 10 07:07:13 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:13 squeezeplay: INFO audio.decode - Playback.lua:411 51.9%/98.2% Jun 10 07:07:14 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:14 squeezeplay: INFO audio.decode - Playback.lua:411 52.1%/98.2% Jun 10 07:07:15 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:15 squeezeplay: INFO audio.decode - Playback.lua:411 52.3%/98.2% Jun 10 07:07:16 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:16 squeezeplay: INFO audio.decode - Playback.lua:411 52.4%/98.2% Jun 10 07:07:17 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:17 squeezeplay: INFO audio.decode - Playback.lua:411 52.5%/98.2% Jun 10 07:07:18 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:18 squeezeplay: INFO audio.decode - Playback.lua:411 52.7%/98.2% Jun 10 07:07:19 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:19 squeezeplay: INFO audio.decode - Playback.lua:411 53.0%/98.2% Jun 10 07:07:20 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:20 squeezeplay: INFO audio.decode - Playback.lua:411 53.2%/98.2% Jun 10 07:07:21 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:21 squeezeplay: INFO audio.decode - Playback.lua:411 53.4%/98.2% Jun 10 07:07:22 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:22 squeezeplay: INFO audio.decode - Playback.lua:411 53.6%/98.2% Jun 10 07:07:23 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:23 squeezeplay: INFO audio.decode - Playback.lua:411 53.8%/98.2% Jun 10 07:07:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:07:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:25 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:25 squeezeplay: INFO audio.decode - Playback.lua:411 54.0%/98.2% Jun 10 07:07:26 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:26 squeezeplay: INFO audio.decode - Playback.lua:411 54.3%/98.2% Jun 10 07:07:27 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:27 squeezeplay: INFO audio.decode - Playback.lua:411 54.5%/98.2% Jun 10 07:07:28 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:28 squeezeplay: INFO audio.decode - Playback.lua:411 54.7%/98.2% Jun 10 07:07:29 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:29 squeezeplay: INFO audio.decode - Playback.lua:411 54.9%/98.2% Jun 10 07:07:30 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:30 squeezeplay: INFO audio.decode - Playback.lua:411 55.1%/98.2% Jun 10 07:07:31 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:31 squeezeplay: INFO audio.decode - Playback.lua:411 55.3%/98.2% Jun 10 07:07:32 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:32 squeezeplay: INFO audio.decode - Playback.lua:411 55.6%/98.2% Jun 10 07:07:33 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:33 squeezeplay: INFO audio.decode - Playback.lua:411 55.8%/98.2% Jun 10 07:07:34 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:34 squeezeplay: INFO audio.decode - Playback.lua:411 56.0%/98.2% Jun 10 07:07:35 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:35 squeezeplay: INFO audio.decode - Playback.lua:411 56.2%/98.2% Jun 10 07:07:36 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:36 squeezeplay: INFO audio.decode - Playback.lua:411 56.4%/98.2% Jun 10 07:07:37 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:37 squeezeplay: INFO audio.decode - Playback.lua:411 56.6%/98.2% Jun 10 07:07:39 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:39 squeezeplay: INFO audio.decode - Playback.lua:411 56.9%/98.2% Jun 10 07:07:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:40 squeezeplay: INFO audio.decode - Playback.lua:411 57.1%/98.2% Jun 10 07:07:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:41 squeezeplay: INFO audio.decode - Playback.lua:411 57.3%/98.2% Jun 10 07:07:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:42 squeezeplay: INFO audio.decode - Playback.lua:411 57.4%/98.2% Jun 10 07:07:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:43 squeezeplay: INFO audio.decode - Playback.lua:411 57.6%/98.2% Jun 10 07:07:44 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:44 squeezeplay: INFO audio.decode - Playback.lua:411 57.7%/98.2% Jun 10 07:07:45 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:45 squeezeplay: INFO audio.decode - Playback.lua:411 57.9%/98.2% Jun 10 07:07:46 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:46 squeezeplay: INFO audio.decode - Playback.lua:411 58.2%/98.2% Jun 10 07:07:47 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:47 squeezeplay: INFO audio.decode - Playback.lua:411 58.4%/98.2% Jun 10 07:07:48 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:48 squeezeplay: INFO audio.decode - Playback.lua:411 58.6%/98.2% Jun 10 07:07:49 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:49 squeezeplay: INFO audio.decode - Playback.lua:411 58.8%/98.2% Jun 10 07:07:50 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:50 squeezeplay: INFO audio.decode - Playback.lua:411 59.0%/98.2% Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 333 Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(333, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(333, nil, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:07:51 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:51 squeezeplay: INFO audio.decode - Playback.lua:411 59.2%/98.2% Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(333, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 333 Jun 10 07:07:51 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:07:51 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:07:51 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 333 Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(333, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(333, nil, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(333, nil) Jun 10 07:07:51 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 333 Jun 10 07:07:51 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:07:51 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:07:51 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:07:52 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:52 squeezeplay: INFO audio.decode - Playback.lua:411 59.5%/98.2% Jun 10 07:07:52 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:52 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:07:52 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 333 Jun 10 07:07:52 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:07:53 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:53 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(333, nil) Jun 10 07:07:53 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(333, nil, nil) Jun 10 07:07:53 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:07:53 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:53 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:07:53 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:07:53 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(333, nil) Jun 10 07:07:53 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 333 Jun 10 07:07:53 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:07:53 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:07:53 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:07:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:54 squeezeplay: INFO audio.decode - Playback.lua:411 59.7%/98.2% Jun 10 07:07:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:07:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:55 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:55 squeezeplay: INFO audio.decode - Playback.lua:411 59.9%/98.2% Jun 10 07:07:56 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:56 squeezeplay: INFO audio.decode - Playback.lua:411 60.1%/98.2% Jun 10 07:07:57 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:57 squeezeplay: INFO audio.decode - Playback.lua:411 60.3%/98.2% Jun 10 07:07:58 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:58 squeezeplay: INFO audio.decode - Playback.lua:411 60.5%/98.2% Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 434 Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(434, nil) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(434, nil, nil) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:07:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:07:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:07:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:07:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:07:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:07:59 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:07:59 squeezeplay: INFO audio.decode - Playback.lua:411 60.8%/98.2% Jun 10 07:08:00 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:00 squeezeplay: INFO audio.decode - Playback.lua:411 61.0%/98.2% Jun 10 07:08:01 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:01 squeezeplay: INFO audio.decode - Playback.lua:411 61.2%/98.2% Jun 10 07:08:02 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:02 squeezeplay: INFO audio.decode - Playback.lua:411 61.4%/98.2% Jun 10 07:08:03 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:03 squeezeplay: INFO audio.decode - Playback.lua:411 61.6%/98.2% Jun 10 07:08:04 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:04 squeezeplay: INFO audio.decode - Playback.lua:411 61.8%/98.2% Jun 10 07:08:05 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:05 squeezeplay: INFO audio.decode - Playback.lua:411 62.1%/98.2% Jun 10 07:08:07 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:07 squeezeplay: INFO audio.decode - Playback.lua:411 62.3%/98.2% Jun 10 07:08:08 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:08 squeezeplay: INFO audio.decode - Playback.lua:411 62.5%/98.2% Jun 10 07:08:09 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:09 squeezeplay: INFO audio.decode - Playback.lua:411 62.7%/98.2% Jun 10 07:08:10 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:10 squeezeplay: INFO audio.decode - Playback.lua:411 62.9%/98.2% Jun 10 07:08:11 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:11 squeezeplay: INFO audio.decode - Playback.lua:411 63.1%/98.2% Jun 10 07:08:12 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:12 squeezeplay: INFO audio.decode - Playback.lua:411 63.2%/98.2% Jun 10 07:08:13 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:13 squeezeplay: INFO audio.decode - Playback.lua:411 63.4%/98.2% Jun 10 07:08:14 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:14 squeezeplay: INFO audio.decode - Playback.lua:411 63.6%/98.2% Jun 10 07:08:15 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:15 squeezeplay: INFO audio.decode - Playback.lua:411 63.8%/98.2% Jun 10 07:08:16 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:16 squeezeplay: INFO audio.decode - Playback.lua:411 64.0%/98.2% Jun 10 07:08:17 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:17 squeezeplay: INFO audio.decode - Playback.lua:411 64.2%/98.2% Jun 10 07:08:18 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:18 squeezeplay: INFO audio.decode - Playback.lua:411 64.4%/98.2% Jun 10 07:08:19 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:19 squeezeplay: INFO audio.decode - Playback.lua:411 64.7%/98.2% Jun 10 07:08:20 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:20 squeezeplay: INFO audio.decode - Playback.lua:411 64.9%/98.2% Jun 10 07:08:21 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:21 squeezeplay: INFO audio.decode - Playback.lua:411 65.1%/98.2% Jun 10 07:08:23 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:23 squeezeplay: INFO audio.decode - Playback.lua:411 65.3%/98.2% Jun 10 07:08:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:24 squeezeplay: INFO audio.decode - Playback.lua:411 65.5%/98.2% Jun 10 07:08:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:08:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:25 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:25 squeezeplay: INFO audio.decode - Playback.lua:411 65.7%/98.2% Jun 10 07:08:26 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:26 squeezeplay: INFO audio.decode - Playback.lua:411 66.0%/98.2% Jun 10 07:08:27 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:27 squeezeplay: INFO audio.decode - Playback.lua:411 66.2%/98.2% Jun 10 07:08:28 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:28 squeezeplay: INFO audio.decode - Playback.lua:411 66.4%/98.2% Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 333 Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(333, nil) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(333, nil, nil) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(333, nil) Jun 10 07:08:28 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 333 Jun 10 07:08:28 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:08:28 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:08:28 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:08:29 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:29 squeezeplay: INFO audio.decode - Playback.lua:411 66.6%/98.2% Jun 10 07:08:30 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:30 squeezeplay: INFO audio.decode - Playback.lua:411 66.8%/98.2% Jun 10 07:08:31 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:31 squeezeplay: INFO audio.decode - Playback.lua:411 67.0%/98.2% Jun 10 07:08:32 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:32 squeezeplay: INFO audio.decode - Playback.lua:411 67.3%/98.2% Jun 10 07:08:33 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:33 squeezeplay: INFO audio.decode - Playback.lua:411 67.5%/98.2% Jun 10 07:08:34 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:34 squeezeplay: INFO audio.decode - Playback.lua:411 67.7%/98.2% Jun 10 07:08:35 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:35 squeezeplay: INFO audio.decode - Playback.lua:411 67.7%/98.2% Jun 10 07:08:36 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:36 squeezeplay: INFO audio.decode - Playback.lua:411 67.9%/98.2% Jun 10 07:08:37 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:37 squeezeplay: INFO audio.decode - Playback.lua:411 68.1%/98.2% Jun 10 07:08:38 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:38 squeezeplay: INFO audio.decode - Playback.lua:411 68.3%/98.2% Jun 10 07:08:39 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:39 squeezeplay: INFO audio.decode - Playback.lua:411 68.6%/98.2% Jun 10 07:08:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:41 squeezeplay: INFO audio.decode - Playback.lua:411 68.8%/98.2% Jun 10 07:08:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:42 squeezeplay: INFO audio.decode - Playback.lua:411 69.0%/98.2% Jun 10 07:08:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:43 squeezeplay: INFO audio.decode - Playback.lua:411 69.2%/98.2% Jun 10 07:08:44 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:44 squeezeplay: INFO audio.decode - Playback.lua:411 69.4%/98.2% Jun 10 07:08:45 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:45 squeezeplay: INFO audio.decode - Playback.lua:411 69.6%/98.2% Jun 10 07:08:46 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:46 squeezeplay: INFO audio.decode - Playback.lua:411 69.9%/98.2% Jun 10 07:08:47 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:47 squeezeplay: INFO audio.decode - Playback.lua:411 70.1%/98.2% Jun 10 07:08:48 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:48 squeezeplay: INFO audio.decode - Playback.lua:411 70.3%/98.2% Jun 10 07:08:49 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:49 squeezeplay: INFO audio.decode - Playback.lua:411 70.5%/98.2% Jun 10 07:08:50 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:50 squeezeplay: INFO audio.decode - Playback.lua:411 70.7%/98.2% Jun 10 07:08:51 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:51 squeezeplay: INFO audio.decode - Playback.lua:411 70.9%/98.2% Jun 10 07:08:52 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:52 squeezeplay: INFO audio.decode - Playback.lua:411 71.2%/98.2% Jun 10 07:08:53 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:53 squeezeplay: INFO audio.decode - Playback.lua:411 71.4%/98.2% Jun 10 07:08:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:08:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:54 squeezeplay: INFO audio.decode - Playback.lua:411 71.6%/98.2% Jun 10 07:08:55 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:55 squeezeplay: INFO audio.decode - Playback.lua:411 71.8%/98.2% Jun 10 07:08:56 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:56 squeezeplay: INFO audio.decode - Playback.lua:411 71.9%/98.2% Jun 10 07:08:57 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:57 squeezeplay: INFO audio.decode - Playback.lua:411 72.2%/98.2% Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 434 Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(434, nil) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(434, nil, nil) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:08:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:08:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:08:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:08:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:08:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:08:59 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:08:59 squeezeplay: INFO audio.decode - Playback.lua:411 72.3%/98.2% Jun 10 07:09:00 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:00 squeezeplay: INFO audio.decode - Playback.lua:411 72.5%/98.2% Jun 10 07:09:01 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:01 squeezeplay: INFO audio.decode - Playback.lua:411 72.7%/98.2% Jun 10 07:09:02 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:02 squeezeplay: INFO audio.decode - Playback.lua:411 72.9%/98.2% Jun 10 07:09:03 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:03 squeezeplay: INFO audio.decode - Playback.lua:411 73.1%/98.2% Jun 10 07:09:04 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:04 squeezeplay: INFO audio.decode - Playback.lua:411 73.3%/98.2% Jun 10 07:09:05 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:05 squeezeplay: INFO audio.decode - Playback.lua:411 73.5%/98.2% Jun 10 07:09:06 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:06 squeezeplay: INFO audio.decode - Playback.lua:411 73.7%/98.2% Jun 10 07:09:07 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:07 squeezeplay: INFO audio.decode - Playback.lua:411 74.0%/98.2% Jun 10 07:09:08 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:08 squeezeplay: INFO audio.decode - Playback.lua:411 74.2%/98.2% Jun 10 07:09:09 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:09 squeezeplay: INFO audio.decode - Playback.lua:411 74.4%/98.2% Jun 10 07:09:10 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:10 squeezeplay: INFO audio.decode - Playback.lua:411 74.6%/98.2% Jun 10 07:09:11 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:11 squeezeplay: INFO audio.decode - Playback.lua:411 74.8%/98.2% Jun 10 07:09:12 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:12 squeezeplay: INFO audio.decode - Playback.lua:411 75.0%/98.2% Jun 10 07:09:13 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:13 squeezeplay: INFO audio.decode - Playback.lua:411 75.3%/98.2% Jun 10 07:09:14 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:14 squeezeplay: INFO audio.decode - Playback.lua:411 75.5%/98.2% Jun 10 07:09:15 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:15 squeezeplay: INFO audio.decode - Playback.lua:411 75.7%/98.2% Jun 10 07:09:17 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:17 squeezeplay: INFO audio.decode - Playback.lua:411 75.9%/98.2% Jun 10 07:09:18 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:18 squeezeplay: INFO audio.decode - Playback.lua:411 76.1%/98.2% Jun 10 07:09:19 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:19 squeezeplay: INFO audio.decode - Playback.lua:411 76.3%/98.2% Jun 10 07:09:20 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:20 squeezeplay: INFO audio.decode - Playback.lua:411 76.6%/98.2% Jun 10 07:09:21 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:21 squeezeplay: INFO audio.decode - Playback.lua:411 76.8%/98.2% Jun 10 07:09:22 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:22 squeezeplay: INFO audio.decode - Playback.lua:411 76.8%/98.2% Jun 10 07:09:23 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:23 squeezeplay: INFO audio.decode - Playback.lua:411 77.0%/98.2% Jun 10 07:09:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:24 squeezeplay: INFO audio.decode - Playback.lua:411 77.2%/98.2% Jun 10 07:09:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:09:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:25 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:25 squeezeplay: INFO audio.decode - Playback.lua:411 77.4%/98.2% Jun 10 07:09:26 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:26 squeezeplay: INFO audio.decode - Playback.lua:411 77.6%/98.2% Jun 10 07:09:27 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:27 squeezeplay: INFO audio.decode - Playback.lua:411 77.9%/98.2% Jun 10 07:09:28 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:28 squeezeplay: INFO audio.decode - Playback.lua:411 78.1%/98.2% Jun 10 07:09:29 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:29 squeezeplay: INFO audio.decode - Playback.lua:411 78.3%/98.2% Jun 10 07:09:30 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:30 squeezeplay: INFO audio.decode - Playback.lua:411 78.5%/98.2% Jun 10 07:09:31 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:31 squeezeplay: INFO audio.decode - Playback.lua:411 78.7%/98.2% Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 333 Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(333, nil) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(333, nil, nil) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(333, nil) Jun 10 07:09:32 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 333 Jun 10 07:09:32 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:09:32 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:09:32 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:09:33 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:33 squeezeplay: INFO audio.decode - Playback.lua:411 78.9%/98.2% Jun 10 07:09:34 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:34 squeezeplay: INFO audio.decode - Playback.lua:411 79.2%/98.2% Jun 10 07:09:35 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:35 squeezeplay: INFO audio.decode - Playback.lua:411 79.4%/98.2% Jun 10 07:09:36 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:36 squeezeplay: INFO audio.decode - Playback.lua:411 79.6%/98.2% Jun 10 07:09:37 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:37 squeezeplay: INFO audio.decode - Playback.lua:411 79.8%/98.2% Jun 10 07:09:38 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:38 squeezeplay: INFO audio.decode - Playback.lua:411 80.0%/98.2% Jun 10 07:09:39 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:39 squeezeplay: INFO audio.decode - Playback.lua:411 80.2%/98.2% Jun 10 07:09:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:40 squeezeplay: INFO audio.decode - Playback.lua:411 80.3%/98.2% Jun 10 07:09:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:41 squeezeplay: INFO audio.decode - Playback.lua:411 80.5%/98.2% Jun 10 07:09:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:42 squeezeplay: INFO audio.decode - Playback.lua:411 80.7%/98.2% Jun 10 07:09:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:43 squeezeplay: INFO audio.decode - Playback.lua:411 80.9%/98.2% Jun 10 07:09:44 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:44 squeezeplay: INFO audio.decode - Playback.lua:411 81.1%/98.2% Jun 10 07:09:45 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:45 squeezeplay: INFO audio.decode - Playback.lua:411 81.3%/98.2% Jun 10 07:09:46 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:46 squeezeplay: INFO audio.decode - Playback.lua:411 81.5%/98.2% Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 333 Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(333, nil) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(333, nil, nil) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(333, nil) Jun 10 07:09:46 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 333 Jun 10 07:09:46 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/menustatus/00:04:20:26:61:03 id=3 OK Jun 10 07:09:46 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/menustatus/00:04:20:26:61:03 Jun 10 07:09:46 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x9594d8 Jun 10 07:09:47 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:47 squeezeplay: INFO audio.decode - Playback.lua:411 81.8%/98.2% Jun 10 07:09:48 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:48 squeezeplay: INFO audio.decode - Playback.lua:411 82.0%/98.2% Jun 10 07:09:49 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:49 squeezeplay: INFO audio.decode - Playback.lua:411 82.2%/98.2% Jun 10 07:09:50 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:50 squeezeplay: INFO audio.decode - Playback.lua:411 82.4%/98.2% Jun 10 07:09:51 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:51 squeezeplay: INFO audio.decode - Playback.lua:411 82.6%/98.2% Jun 10 07:09:53 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:53 squeezeplay: INFO audio.decode - Playback.lua:411 82.8%/98.2% Jun 10 07:09:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:54 squeezeplay: INFO audio.decode - Playback.lua:411 83.1%/98.2% Jun 10 07:09:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:09:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:55 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:55 squeezeplay: INFO audio.decode - Playback.lua:411 83.3%/98.2% Jun 10 07:09:56 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:56 squeezeplay: INFO audio.decode - Playback.lua:411 83.5%/98.2% Jun 10 07:09:57 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:57 squeezeplay: INFO audio.decode - Playback.lua:411 83.7%/98.2% Jun 10 07:09:58 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:58 squeezeplay: INFO audio.decode - Playback.lua:411 83.9%/98.2% Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 434 Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(434, nil) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(434, nil, nil) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:09:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:09:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:09:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:09:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:09:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:09:59 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:09:59 squeezeplay: INFO audio.decode - Playback.lua:411 84.1%/98.2% Jun 10 07:10:00 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:00 squeezeplay: INFO audio.decode - Playback.lua:411 84.4%/98.2% Jun 10 07:10:01 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:01 squeezeplay: INFO audio.decode - Playback.lua:411 84.6%/98.2% Jun 10 07:10:02 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:02 squeezeplay: INFO audio.decode - Playback.lua:411 84.8%/98.2% Jun 10 07:10:03 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:03 squeezeplay: INFO audio.decode - Playback.lua:411 85.0%/98.2% Jun 10 07:10:04 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:04 squeezeplay: INFO audio.decode - Playback.lua:411 85.2%/98.2% Jun 10 07:10:05 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:05 squeezeplay: INFO audio.decode - Playback.lua:411 85.4%/98.2% Jun 10 07:10:07 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:07 squeezeplay: INFO audio.decode - Playback.lua:411 85.5%/98.2% Jun 10 07:10:08 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:08 squeezeplay: INFO audio.decode - Playback.lua:411 85.7%/98.2% Jun 10 07:10:09 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:09 squeezeplay: INFO audio.decode - Playback.lua:411 85.9%/98.2% Jun 10 07:10:10 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:10 squeezeplay: INFO audio.decode - Playback.lua:411 86.1%/98.2% Jun 10 07:10:11 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:11 squeezeplay: INFO audio.decode - Playback.lua:411 86.3%/98.2% Jun 10 07:10:12 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:12 squeezeplay: INFO audio.decode - Playback.lua:411 86.5%/98.2% Jun 10 07:10:13 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:13 squeezeplay: INFO audio.decode - Playback.lua:411 86.7%/98.2% Jun 10 07:10:14 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:14 squeezeplay: INFO audio.decode - Playback.lua:411 87.0%/98.2% Jun 10 07:10:15 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:15 squeezeplay: INFO audio.decode - Playback.lua:411 87.2%/98.2% Jun 10 07:10:16 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:16 squeezeplay: INFO audio.decode - Playback.lua:411 87.4%/98.2% Jun 10 07:10:17 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:17 squeezeplay: INFO audio.decode - Playback.lua:411 87.6%/98.2% Jun 10 07:10:18 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:18 squeezeplay: INFO audio.decode - Playback.lua:411 87.8%/98.2% Jun 10 07:10:19 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:19 squeezeplay: INFO audio.decode - Playback.lua:411 88.0%/98.2% Jun 10 07:10:20 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:20 squeezeplay: INFO audio.decode - Playback.lua:411 88.3%/98.2% Jun 10 07:10:21 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:21 squeezeplay: INFO audio.decode - Playback.lua:411 88.5%/98.2% Jun 10 07:10:22 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:22 squeezeplay: INFO audio.decode - Playback.lua:411 88.7%/98.2% Jun 10 07:10:23 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:23 squeezeplay: INFO audio.decode - Playback.lua:411 88.9%/98.2% Jun 10 07:10:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:10:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:25 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:25 squeezeplay: INFO audio.decode - Playback.lua:411 89.1%/98.2% Jun 10 07:10:26 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:26 squeezeplay: INFO audio.decode - Playback.lua:411 89.3%/98.2% Jun 10 07:10:27 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:27 squeezeplay: INFO audio.decode - Playback.lua:411 89.6%/98.2% Jun 10 07:10:28 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:28 squeezeplay: INFO audio.decode - Playback.lua:411 89.6%/98.2% Jun 10 07:10:29 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:29 squeezeplay: INFO audio.decode - Playback.lua:411 90.0%/98.2% Jun 10 07:10:30 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:30 squeezeplay: INFO audio.decode - Playback.lua:411 90.1%/98.2% Jun 10 07:10:31 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:31 squeezeplay: INFO audio.decode - Playback.lua:411 90.2%/98.2% Jun 10 07:10:32 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:32 squeezeplay: INFO audio.decode - Playback.lua:411 90.4%/98.2% Jun 10 07:10:33 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:33 squeezeplay: INFO audio.decode - Playback.lua:411 90.6%/98.2% Jun 10 07:10:34 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:34 squeezeplay: INFO audio.decode - Playback.lua:411 90.9%/98.2% Jun 10 07:10:35 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:35 squeezeplay: INFO audio.decode - Playback.lua:411 91.1%/98.2% Jun 10 07:10:36 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:36 squeezeplay: INFO audio.decode - Playback.lua:411 91.3%/98.2% Jun 10 07:10:37 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:37 squeezeplay: INFO audio.decode - Playback.lua:411 91.5%/98.2% Jun 10 07:10:38 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:38 squeezeplay: INFO audio.decode - Playback.lua:411 91.7%/98.2% Jun 10 07:10:39 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:39 squeezeplay: INFO audio.decode - Playback.lua:411 91.9%/98.2% Jun 10 07:10:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:41 squeezeplay: INFO audio.decode - Playback.lua:411 92.2%/98.2% Jun 10 07:10:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:42 squeezeplay: INFO audio.decode - Playback.lua:411 92.4%/98.2% Jun 10 07:10:43 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:43 squeezeplay: INFO audio.decode - Playback.lua:411 92.6%/98.2% Jun 10 07:10:44 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:44 squeezeplay: INFO audio.decode - Playback.lua:411 92.8%/98.2% Jun 10 07:10:45 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:45 squeezeplay: INFO audio.decode - Playback.lua:411 93.0%/98.2% Jun 10 07:10:46 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:46 squeezeplay: INFO audio.decode - Playback.lua:411 93.2%/98.2% Jun 10 07:10:47 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:47 squeezeplay: INFO audio.decode - Playback.lua:411 93.4%/98.2% Jun 10 07:10:48 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:48 squeezeplay: INFO audio.decode - Playback.lua:411 93.5%/98.2% Jun 10 07:10:49 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:49 squeezeplay: INFO audio.decode - Playback.lua:411 93.7%/98.2% Jun 10 07:10:50 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:50 squeezeplay: INFO audio.decode - Playback.lua:411 93.9%/98.2% Jun 10 07:10:51 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:51 squeezeplay: INFO audio.decode - Playback.lua:411 94.1%/98.2% Jun 10 07:10:52 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:52 squeezeplay: INFO audio.decode - Playback.lua:411 94.3%/98.2% Jun 10 07:10:53 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:53 squeezeplay: INFO audio.decode - Playback.lua:411 94.5%/98.2% Jun 10 07:10:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:10:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:54 squeezeplay: INFO audio.decode - Playback.lua:411 94.7%/98.2% Jun 10 07:10:55 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:55 squeezeplay: INFO audio.decode - Playback.lua:411 95.0%/98.2% Jun 10 07:10:56 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:56 squeezeplay: INFO audio.decode - Playback.lua:411 95.2%/98.2% Jun 10 07:10:57 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:57 squeezeplay: INFO audio.decode - Playback.lua:411 95.4%/98.2% Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 434 Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(434, nil) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(434, nil, nil) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:10:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:10:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:10:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:10:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:10:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:10:58 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:58 squeezeplay: INFO audio.decode - Playback.lua:411 95.6%/98.2% Jun 10 07:10:59 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:10:59 squeezeplay: INFO audio.decode - Playback.lua:411 95.8%/98.2% Jun 10 07:11:01 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:01 squeezeplay: INFO audio.decode - Playback.lua:411 96.0%/98.2% Jun 10 07:11:02 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:02 squeezeplay: INFO audio.decode - Playback.lua:411 96.3%/98.2% Jun 10 07:11:03 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:03 squeezeplay: INFO audio.decode - Playback.lua:411 96.5%/98.2% Jun 10 07:11:04 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:04 squeezeplay: INFO audio.decode - Playback.lua:411 96.7%/98.2% Jun 10 07:11:05 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:05 squeezeplay: INFO audio.decode - Playback.lua:411 96.9%/98.2% Jun 10 07:11:06 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:06 squeezeplay: INFO audio.decode - Playback.lua:411 97.1%/98.2% Jun 10 07:11:07 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:07 squeezeplay: INFO audio.decode - Playback.lua:411 97.2%/98.2% Jun 10 07:11:08 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:08 squeezeplay: INFO audio.decode - Playback.lua:411 97.5%/98.2% Jun 10 07:11:09 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:09 squeezeplay: INFO audio.decode - Playback.lua:411 97.6%/98.2% Jun 10 07:11:10 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:10 squeezeplay: INFO audio.decode - Playback.lua:411 97.8%/98.2% Jun 10 07:11:11 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:11 squeezeplay: INFO audio.decode - Playback.lua:411 98.0%/98.2% Jun 10 07:11:12 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:12 squeezeplay: INFO audio.decode - Playback.lua:411 98.2%/98.2% Jun 10 07:11:13 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:13 squeezeplay: INFO audio.decode - Playback.lua:411 98.4%/98.2% Jun 10 07:11:14 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:14 squeezeplay: INFO audio.decode - Playback.lua:411 98.6%/98.2% Jun 10 07:11:16 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:16 squeezeplay: INFO audio.decode - Playback.lua:411 98.9%/98.2% Jun 10 07:11:17 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:17 squeezeplay: INFO audio.decode - Playback.lua:411 99.1%/98.2% Jun 10 07:11:18 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:18 squeezeplay: INFO audio.decode - Playback.lua:411 99.3%/98.2% Jun 10 07:11:19 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:19 squeezeplay: INFO audio.decode - Playback.lua:411 99.5%/98.2% Jun 10 07:11:20 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:20 squeezeplay: INFO audio.decode - Playback.lua:411 99.7%/98.2% Jun 10 07:11:21 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:21 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:22 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:22 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:23 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:23 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:11:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:24 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:24 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:25 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:25 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:26 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:26 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:27 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:27 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:28 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:28 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:30 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:30 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:31 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:31 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:32 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:32 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:33 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:33 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:34 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:34 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:35 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:35 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:36 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:36 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:37 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:37 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:38 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:38 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:39 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:39 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:40 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:40 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:41 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:41 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:42 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:42 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:44 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:44 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:45 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:45 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:46 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:46 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:47 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:47 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:48 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:48 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:49 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:49 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:50 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:50 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:51 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:51 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:52 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:52 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:53 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:53 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:54 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:498 read opcode=strm #28 Jun 10 07:11:54 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:55 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:55 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:56 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:56 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:57 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:57 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(3, nil) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:657 SocketHttp.jive-http-chunked.source - size: 434 Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(434, nil) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:670 SocketHttp.jive-http-chunked.source(434, nil, nil) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(nil, timeout) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:800 SocketHttp {mysqueezebox.com_Chunked}:t_rcvResponse.pump(jive-http-chunked, nil) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:644 SocketHttp.jive-http-chunked.source(0, nil) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:680 SocketHttp.jive-http-chunked.source 3 (0, nil, nil) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:729 SocketHttp.jive-by-chunk.sink(434, nil) Jun 10 07:11:58 squeezeplay: DEBUG net.http - SocketHttp.lua:739 SocketHttp.jive-by-chunk.sink: chunk bytes: 434 Jun 10 07:11:58 squeezeplay: DEBUG net.comet - Comet.lua:878 Comet {mysqueezebox.com}: _response, /1901121X94e674c91e6912e3d9118ccef35303beX000420266103X1X1276118943X7b44ca66/slim/serverstatus id=1 OK Jun 10 07:11:58 squeezeplay: DEBUG net.comet - Comet.lua:939 Comet {mysqueezebox.com}: _response, notifiying callbacks for /slim/serverstatus Jun 10 07:11:58 squeezeplay: DEBUG net.comet - Comet.lua:942 callback to: function: 0x70e570 Jun 10 07:11:58 squeezeplay: DEBUG squeezebox.server - SlimServer.lua:172 SlimServer {mysqueezebox.com}:_serverstatusSink() Jun 10 07:11:58 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:58 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:11:59 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:11:59 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:00 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:00 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:01 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:01 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:02 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:02 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:04 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:04 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:05 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:05 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:06 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:06 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:07 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:07 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:08 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:08 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:09 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:09 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:10 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:10 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:11 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:11 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:12 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:12 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:13 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:13 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:14 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:14 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:15 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT Jun 10 07:12:15 squeezeplay: INFO audio.decode - Playback.lua:411 99.9%/98.2% Jun 10 07:12:16 squeezeplay: DEBUG net.slimproto - SlimProto.lua:702 send opcode=STAT