{\rtf1\mac\ansicpg10000\cocoartf824\cocoasubrtf470 {\fonttbl\f0\fswiss\fcharset77 Helvetica;} {\colortbl;\red255\green255\blue255;} \paperw11900\paperh16840\margl1440\margr1440\vieww9000\viewh8400\viewkind0 \pard\tx566\tx1133\tx1700\tx2267\tx2834\tx3401\tx3968\tx4535\tx5102\tx5669\tx6236\tx6803\ql\qnatural\pardirnatural \f0\fs24 \cf0 [21:24:12.0149] Slim::Control::Queries::serverstatusQuery (2917) serverstatusQuery()\ [21:24:12.0284] Slim::Control::Request::dump (2256) Request: Query [serverstatus] from JSONRPC (Done)\ [21:24:12.0289] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:24:12.0294] Slim::Control::Request::dump (2260) Param: [_quantity] = [999]\ [21:24:12.0298] Slim::Control::Request::dump (2282) Result: [version] = [7.1]\ [21:24:12.0301] Slim::Control::Request::dump (2282) Result: [info total albums] = [156]\ [21:24:12.0304] Slim::Control::Request::dump (2282) Result: [info total artists] = [398]\ [21:24:12.0308] Slim::Control::Request::dump (2282) Result: [info total genres] = [32]\ [21:24:12.0311] Slim::Control::Request::dump (2282) Result: [info total songs] = [1769]\ [21:24:12.0314] Slim::Control::Request::dump (2282) Result: [player count] = [1]\ [21:24:12.0318] Slim::Control::Request::dump (2269) Result: [players_loop] is loop with 1 elements:\ [21:24:12.0322] Slim::Control::Request::dump (2277) Result: 0. [playerid] = [00:04:20:16:06:17]\ [21:24:12.0325] Slim::Control::Request::dump (2277) Result: 0. [uuid] = [de2d825317cb52f96676afe3f0694635]\ [21:24:12.0330] Slim::Control::Request::dump (2277) Result: 0. [ip] = [192.168.1.70:45753]\ [21:24:12.0334] Slim::Control::Request::dump (2277) Result: 0. [name] = [Ray]\ [21:24:12.0337] Slim::Control::Request::dump (2277) Result: 0. [model] = [receiver]\ [21:24:12.0340] Slim::Control::Request::dump (2277) Result: 0. [power] = [1]\ [21:24:12.0344] Slim::Control::Request::dump (2277) Result: 0. [displaytype] = [none]\ [21:24:12.0347] Slim::Control::Request::dump (2277) Result: 0. [canpoweroff] = [1]\ [21:24:12.0350] Slim::Control::Request::dump (2277) Result: 0. [connected] = [1]\ [21:24:12.0353] Slim::Control::Request::dump (2277) Result: 0. [isplayer] = [1]\ [21:24:12.0356] Slim::Control::Request::dump (2282) Result: [sn player count] = [0]\ [21:24:12.0359] Slim::Control::Request::dump (2282) Result: [other player count] = [4]\ [21:24:12.0362] Slim::Control::Request::dump (2269) Result: [other_players_loop] is loop with 4 elements:\ [21:24:12.0365] Slim::Control::Request::dump (2277) Result: 0. [playerid] = [00:04:20:06:17:4c]\ [21:24:12.0368] Slim::Control::Request::dump (2277) Result: 0. [name] = [Kitchen]\ [21:24:12.0371] Slim::Control::Request::dump (2277) Result: 0. [model] = [squeezebox2]\ [21:24:12.0375] Slim::Control::Request::dump (2277) Result: 0. [server] = [harrypotter]\ [21:24:12.0377] Slim::Control::Request::dump (2277) Result: 0. [serverurl] = [http://192.168.1.1:9000/]\ [21:24:12.0380] Slim::Control::Request::dump (2277) Result: 1. [playerid] = [00:04:20:1e:00:8c]\ [21:24:12.0383] Slim::Control::Request::dump (2277) Result: 1. [name] = [Bedroom]\ [21:24:12.0386] Slim::Control::Request::dump (2277) Result: 1. [model] = [boom]\ [21:24:12.0389] Slim::Control::Request::dump (2277) Result: 1. [server] = [harrypotter]\ [21:24:12.0392] Slim::Control::Request::dump (2277) Result: 1. [serverurl] = [http://192.168.1.1:9000/]\ [21:24:12.0395] Slim::Control::Request::dump (2277) Result: 2. [playerid] = [00:04:20:10:00:02]\ [21:24:12.0398] Slim::Control::Request::dump (2277) Result: 2. [name] = [Transporter]\ [21:24:12.0401] Slim::Control::Request::dump (2277) Result: 2. [model] = [transporter]\ [21:24:12.0404] Slim::Control::Request::dump (2277) Result: 2. [server] = [harrypotter]\ [21:24:12.0407] Slim::Control::Request::dump (2277) Result: 2. [serverurl] = [http://192.168.1.1:9000/]\ [21:24:12.0410] Slim::Control::Request::dump (2277) Result: 3. [playerid] = [00:04:20:1e:00:12]\ [21:24:12.0412] Slim::Control::Request::dump (2277) Result: 3. [name] = [Squeezebox 4]\ [21:24:12.0415] Slim::Control::Request::dump (2277) Result: 3. [model] = [boom]\ [21:24:12.0418] Slim::Control::Request::dump (2277) Result: 3. [server] = [harrypotter]\ [21:24:12.0421] Slim::Control::Request::dump (2277) Result: 3. [serverurl] = [http://192.168.1.1:9000/]\ [21:24:12.0424] Slim::Control::Request::executeDone (1822) 0\ [21:24:12.0443] Slim::Web::HTTP::sendResponse (1748) Sent 1215 to 127.0.0.1:54230\ [21:24:12.0447] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54230\ [21:24:12.0453] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54230, waiting for next request...\ [21:51:49.9469] Slim::Control::Request::__autoexecute (2534) __autoexecute()\ [21:51:49.9476] Slim::Control::Request::execute (1754) Enter\ [21:51:49.9480] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from /85506c45/slim/playerstatus/00:04:20:16:06:17|4| (Dispatchable)\ [21:51:49.9484] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:51:49.9487] Slim::Control::Request::dump (2260) Param: [_quantity] = [10]\ [21:51:49.9490] Slim::Control::Request::dump (2260) Param: [menu] = [menu]\ [21:51:49.9494] Slim::Control::Request::dump (2260) Param: [subscribe] = [30]\ [21:51:49.9498] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:51:49.9519] Slim::Control::Queries::statusQuery (3371) statusQuery(): setup base for jive\ [21:51:49.9524] Slim::Control::Queries::statusQuery (3510) statusQuery(): setting up subscription\ [21:51:49.9527] Slim::Control::Request::registerAutoExecute (2038) registerAutoExecute()\ [21:51:49.9531] Slim::Control::Request::registerAutoExecute (2066) Old friend: 85506c45 - status - 00:04:20:16:06:17\ [21:51:49.9535] Slim::Control::Request::registerAutoExecute (2086) .. set ourself up\ [21:51:49.9542] Slim::Control::Request::registerAutoExecute (2094) .. starting timer: 30\ [21:51:49.9547] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from /85506c45/slim/playerstatus/00:04:20:16:06:17|4| (Done)\ [21:51:49.9550] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:51:49.9554] Slim::Control::Request::dump (2260) Param: [_quantity] = [10]\ [21:51:49.9557] Slim::Control::Request::dump (2260) Param: [menu] = [menu]\ [21:51:49.9560] Slim::Control::Request::dump (2260) Param: [subscribe] = [30]\ [21:51:49.9564] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:51:49.9567] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:51:49.9570] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45753]\ [21:51:49.9574] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:51:49.9578] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:51:49.9581] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:51:49.9585] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:51:49.9588] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:51:49.9591] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:51:49.9595] Slim::Control::Request::dump (2282) Result: [count] = [0]\ [21:51:49.9598] Slim::Control::Request::dump (2282) Result: [base] = [HASH(0x7dbcec)]\ [21:51:49.9601] Slim::Control::Request::executeDone (1822) 0\ [21:51:49.9605] Slim::Web::Cometd::requestCallback (832) requestCallback got results for /85506c45/slim/playerstatus/00:04:20:16:06:17 / 4\ [21:51:49.9609] Slim::Web::Cometd::Manager::deliver_events (209) Sending event on channel /85506c45/slim/playerstatus/00:04:20:16:06:17 to 85506c45\ [21:51:49.9632] Slim::Web::Cometd::Manager::deliver_events (223) Delivering events to 85506c45:\ [\ \{\ channel => "/85506c45/slim/playerstatus/00:04:20:16:06:17",\ data => \{\ # tied Tie::IxHash\ base => \{\ actions => \{\ go => \{\ cmd => ["trackinfo", "items"],\ itemsParams => "params",\ params => \{ context => "playlist", menu => "nowhere" \},\ \},\ \},\ window => \{ titleStyle => "album" \},\ \},\ count => 0,\ "mixer volume" => "76.25",\ mode => "stop",\ player_connected => 1,\ player_ip => "192.168.1.70:45753",\ player_name => "Ray",\ "playlist repeat" => 2,\ "playlist shuffle" => 0,\ playlist_tracks => 0,\ power => 1,\ \},\ ext => \{ priority => "" \},\ id => 4,\ \},\ ]\ [21:51:49.9667] Slim::Web::Cometd::sendHTTPResponse (664) Sending Cometd chunk:\ [\{"data":\{"player_name":"Ray","player_connected":1,"player_ip":"192.168.1.70:45753","power":1,"mode":"stop","mixer volume":76.25,"playlist repeat":2,"playlist shuffle":0,"playlist_tracks":0,"count":0,"base":\{"actions":\{"go":\{"params":\{"context":"playlist","menu":"nowhere"\},"itemsParams":"params","cmd":["trackinfo","items"]\}\},"window":\{"titleStyle":"album"\}\}\},"id":"4","channel":"/85506c45/slim/playerstatus/00:04:20:16:06:17","ext":\{"priority":""\}\}]\ [21:51:49.9676] Slim::Web::HTTP::sendResponse (1748) Sent 458 to 192.168.1.73:44110\ [21:51:49.9680] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 192.168.1.73:44110\ [21:51:49.9688] Slim::Web::HTTP::sendResponse (1706) No segment to send to 192.168.1.73:44110, waiting for next request...\ [21:51:49.9722] Slim::Control::Request::__autoexecute (2534) __autoexecute()\ [21:51:49.9728] Slim::Control::Request::execute (1754) Enter\ [21:51:49.9732] Slim::Control::Request::dump (2256) Request: Query [serverstatus] from /85506c45/slim/serverstatus|1| (Dispatchable)\ [21:51:49.9737] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:51:49.9740] Slim::Control::Request::dump (2260) Param: [_quantity] = [50]\ [21:51:49.9746] Slim::Control::Request::dump (2260) Param: [subscribe] = [60]\ [21:51:49.9750] Slim::Control::Queries::serverstatusQuery (2917) serverstatusQuery()\ [21:51:50.0210] Slim::Control::Request::registerAutoExecute (2038) registerAutoExecute()\ [21:51:50.0213] Slim::Control::Request::registerAutoExecute (2066) Old friend: 85506c45 - serverstatus - global\ [21:51:50.0217] Slim::Control::Request::registerAutoExecute (2086) .. set ourself up\ [21:51:50.0221] Slim::Control::Request::registerAutoExecute (2094) .. starting timer: 60\ [21:51:50.0224] Slim::Control::Request::dump (2256) Request: Query [serverstatus] from /85506c45/slim/serverstatus|1| (Done)\ [21:51:50.0226] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:51:50.0229] Slim::Control::Request::dump (2260) Param: [_quantity] = [50]\ [21:51:50.0231] Slim::Control::Request::dump (2260) Param: [subscribe] = [60]\ [21:51:50.0233] Slim::Control::Request::dump (2282) Result: [version] = [7.1]\ [21:51:50.0236] Slim::Control::Request::dump (2282) Result: [info total albums] = [156]\ [21:51:50.0238] Slim::Control::Request::dump (2282) Result: [info total artists] = [398]\ [21:51:50.0240] Slim::Control::Request::dump (2282) Result: [info total genres] = [32]\ [21:51:50.0243] Slim::Control::Request::dump (2282) Result: [info total songs] = [1769]\ [21:51:50.0245] Slim::Control::Request::dump (2282) Result: [player count] = [1]\ [21:51:50.0247] Slim::Control::Request::dump (2269) Result: [players_loop] is loop with 1 elements:\ [21:51:50.0250] Slim::Control::Request::dump (2277) Result: 0. [playerid] = [00:04:20:16:06:17]\ [21:51:50.0252] Slim::Control::Request::dump (2277) Result: 0. [uuid] = [de2d825317cb52f96676afe3f0694635]\ [21:51:50.0254] Slim::Control::Request::dump (2277) Result: 0. [ip] = [192.168.1.70:45753]\ [21:51:50.0257] Slim::Control::Request::dump (2277) Result: 0. [name] = [Ray]\ [21:51:50.0259] Slim::Control::Request::dump (2277) Result: 0. [model] = [receiver]\ [21:51:50.0261] Slim::Control::Request::dump (2277) Result: 0. [power] = [1]\ [21:51:50.0264] Slim::Control::Request::dump (2277) Result: 0. [displaytype] = [none]\ [21:51:50.0266] Slim::Control::Request::dump (2277) Result: 0. [canpoweroff] = [1]\ [21:51:50.0268] Slim::Control::Request::dump (2277) Result: 0. [connected] = [1]\ [21:51:50.0271] Slim::Control::Request::dump (2277) Result: 0. [isplayer] = [1]\ [21:51:50.0273] Slim::Control::Request::dump (2282) Result: [sn player count] = [0]\ [21:51:50.0276] Slim::Control::Request::dump (2282) Result: [other player count] = [4]\ [21:51:50.0278] Slim::Control::Request::dump (2269) Result: [other_players_loop] is loop with 4 elements:\ [21:51:50.0281] Slim::Control::Request::dump (2277) Result: 0. [playerid] = [00:04:20:06:17:4c]\ [21:51:50.0283] Slim::Control::Request::dump (2277) Result: 0. [name] = [Kitchen]\ [21:51:50.0286] Slim::Control::Request::dump (2277) Result: 0. [model] = [squeezebox2]\ [21:51:50.0288] Slim::Control::Request::dump (2277) Result: 0. [server] = [harrypotter]\ [21:51:50.0290] Slim::Control::Request::dump (2277) Result: 0. [serverurl] = [http://harrypotter:9000/]\ [21:51:50.0293] Slim::Control::Request::dump (2277) Result: 1. [playerid] = [00:04:20:1e:00:8c]\ [21:51:50.0295] Slim::Control::Request::dump (2277) Result: 1. [name] = [Bedroom]\ [21:51:50.0298] Slim::Control::Request::dump (2277) Result: 1. [model] = [boom]\ [21:51:50.0300] Slim::Control::Request::dump (2277) Result: 1. [server] = [harrypotter]\ [21:51:50.0303] Slim::Control::Request::dump (2277) Result: 1. [serverurl] = [http://harrypotter:9000/]\ [21:51:50.0305] Slim::Control::Request::dump (2277) Result: 2. [playerid] = [00:04:20:10:00:02]\ [21:51:50.0307] Slim::Control::Request::dump (2277) Result: 2. [name] = [Transporter]\ [21:51:50.0310] Slim::Control::Request::dump (2277) Result: 2. [model] = [transporter]\ [21:51:50.0312] Slim::Control::Request::dump (2277) Result: 2. [server] = [harrypotter]\ [21:51:50.0314] Slim::Control::Request::dump (2277) Result: 2. [serverurl] = [http://harrypotter:9000/]\ [21:51:50.0317] Slim::Control::Request::dump (2277) Result: 3. [playerid] = [00:04:20:1e:00:12]\ [21:51:50.0319] Slim::Control::Request::dump (2277) Result: 3. [name] = [Squeezebox 4]\ [21:51:50.0321] Slim::Control::Request::dump (2277) Result: 3. [model] = [boom]\ [21:51:50.0324] Slim::Control::Request::dump (2277) Result: 3. [server] = [harrypotter]\ [21:51:50.0326] Slim::Control::Request::dump (2277) Result: 3. [serverurl] = [http://harrypotter:9000/]\ [21:51:50.0328] Slim::Control::Request::executeDone (1822) 0\ [21:51:50.0331] Slim::Web::Cometd::requestCallback (832) requestCallback got results for /85506c45/slim/serverstatus / 1\ [21:51:50.0334] Slim::Web::Cometd::Manager::deliver_events (209) Sending event on channel /85506c45/slim/serverstatus to 85506c45\ [21:51:50.0371] Slim::Web::Cometd::Manager::deliver_events (223) Delivering events to 85506c45:\ [\ \{\ channel => "/85506c45/slim/serverstatus",\ data => \{\ # tied Tie::IxHash\ "info total albums" => 156,\ "info total artists" => 398,\ "info total genres" => 32,\ "info total songs" => 1769,\ "other player count" => 4,\ other_players_loop => [\ \{\ # tied Tie::IxHash\ model => "squeezebox2",\ name => "Kitchen",\ playerid => "00:04:20:06:17:4c",\ server => "harrypotter",\ serverurl => "http://harrypotter:9000/",\ \},\ \{\ # tied Tie::IxHash\ model => "boom",\ name => "Bedroom",\ playerid => "00:04:20:1e:00:8c",\ server => "harrypotter",\ serverurl => "http://harrypotter:9000/",\ \},\ \{\ # tied Tie::IxHash\ model => "transporter",\ name => "Transporter",\ playerid => "00:04:20:10:00:02",\ server => "harrypotter",\ serverurl => "http://harrypotter:9000/",\ \},\ \{\ # tied Tie::IxHash\ model => "boom",\ name => "Squeezebox 4",\ playerid => "00:04:20:1e:00:12",\ server => "harrypotter",\ serverurl => "http://harrypotter:9000/",\ \},\ ],\ "player count" => 1,\ players_loop => [\ \{\ # tied Tie::IxHash\ canpoweroff => 1,\ connected => 1,\ displaytype => "none",\ ip => "192.168.1.70:45753",\ isplayer => 1,\ model => "receiver",\ name => "Ray",\ playerid => "00:04:20:16:06:17",\ power => 1,\ uuid => "de2d825317cb52f96676afe3f0694635",\ \},\ ],\ "sn player count" => 0,\ version => "7.1",\ \},\ ext => \{ priority => "" \},\ id => 1,\ \},\ ]\ [21:51:50.0384] Slim::Web::Cometd::sendHTTPResponse (664) Sending Cometd chunk:\ [\{"data":\{"version":"7.1","info total albums":"156","info total artists":"398","info total genres":"32","info total songs":"1769","player count":1,"players_loop":[\{"playerid":"00:04:20:16:06:17","uuid":"de2d825317cb52f96676afe3f0694635","ip":"192.168.1.70:45753","name":"Ray","model":"receiver","power":"1","displaytype":"none","canpoweroff":1,"connected":1,"isplayer":1\}],"sn player count":0,"other player count":4,"other_players_loop":[\{"playerid":"00:04:20:06:17:4c","name":"Kitchen","model":"squeezebox2","server":"harrypotter","serverurl":"http://harrypotter:9000/"\},\{"playerid":"00:04:20:1e:00:8c","name":"Bedroom","model":"boom","server":"harrypotter","serverurl":"http://harrypotter:9000/"\},\{"playerid":"00:04:20:10:00:02","name":"Transporter","model":"transporter","server":"harrypotter","serverurl":"http://harrypotter:9000/"\},\{"playerid":"00:04:20:1e:00:12","name":"Squeezebox 4","model":"boom","server":"harrypotter","serverurl":"http://harrypotter:9000/"\}]\},"id":"1","channel":"/85506c45/slim/serverstatus","ext":\{"priority":""\}\}]\ [21:51:50.0391] Slim::Web::HTTP::sendResponse (1748) Sent 1050 to 192.168.1.73:44110\ [21:51:50.0394] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 192.168.1.73:44110\ [21:51:50.0398] Slim::Web::HTTP::closeHTTPSocket (2519) Closing HTTP socket Slim::Web::HTTP::ClientConn=GLOB(0x56b76cc) with 192.168.1.73:49928 (keep-alive timeout)\ [21:51:50.0405] Slim::Web::HTTP::sendResponse (1706) No segment to send to 192.168.1.73:44110, waiting for next request...\ [21:51:50.0408] Slim::Web::HTTP::closeHTTPSocket (2519) Closing HTTP socket Slim::Web::HTTP::ClientConn=GLOB(0x80791cc) with 127.0.0.1:54231 (keep-alive timeout)\ [21:51:50.0415] Slim::Web::HTTP::closeHTTPSocket (2519) Closing HTTP socket Slim::Web::HTTP::ClientConn=GLOB(0x8095a18) with 127.0.0.1:54230 (keep-alive timeout)\ [21:51:50.8200] Slim::Web::HTTP::acceptHTTP (259) Accepted connection 3 from 192.168.1.73:39410\ [21:51:50.8667] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:51:50.8676] Slim::Web::HTTP::processHTTP (377) HTTP request: from 192.168.1.73:39410 (Slim::Web::HTTP::ClientConn=GLOB(0x5721b50)) for POST HTTP/1.1 /cometd\ [21:51:50.8680] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /cometd HTTP/1.1\ Accept-Language: en\ Host: 192.168.1.71:9000\ User-Agent: Jive/7.1 r2679M\ Content-Length: 273\ Content-Type: text/json\ \ [\{"clientId":"85506c45","connectionType":"streaming","channel":"\\/meta\\/reconnect"\},\{"id":49,"data":\{"request":["00:04:20:16:06:17",["rhapsodydirect","items",0,200,"menu:rhapsodydirect","item_id:1.2.8"]],"response":"\\/85506c45\\/slim\\/request"\},"channel":"\\/slim\\/request"\}]\ ]\ [21:51:50.8687] Slim::Web::HTTP::processHTTP (484) Raw path is [/cometd]\ [21:51:50.8690] Slim::Web::HTTP::processHTTP (492) Handling [/cometd] using raw function\ [21:51:50.8705] Slim::Web::Cometd::handler (145) Cometd request: [\ \{\ channel => "/meta/reconnect",\ clientId => "85506c45",\ connectionType => "streaming",\ \},\ \{\ channel => "/slim/request",\ data => \{\ request => [\ "00:04:20:16:06:17",\ [\ "rhapsodydirect",\ "items",\ 0,\ 200,\ "menu:rhapsodydirect",\ "item_id:1.2.8",\ ],\ ],\ response => "/85506c45/slim/request",\ \},\ id => 49,\ \},\ ]\ [21:51:50.8711] Slim::Web::Cometd::handler (277) Client reconnected: 85506c45\ [21:51:50.8716] Slim::Web::Cometd::Manager::register_connection (55) register_connection: 85506c45\ [21:51:50.8720] Slim::Control::Request::__parse (2367) Request: parse(rhapsodydirect items 0 200 menu:rhapsodydirect item_id:1.2.8)\ [21:51:50.8722] Slim::Control::Request::__parse (2387) ..Trying to match [rhapsodydirect]\ [21:51:50.8725] Slim::Control::Request::__parse (2472) ..[rhapsodydirect] is HASH\ [21:51:50.8727] Slim::Control::Request::__parse (2387) ..Trying to match [items]\ [21:51:50.8730] Slim::Control::Request::__parse (2472) ..[items] is HASH\ [21:51:50.8732] Slim::Control::Request::__parse (2387) ..Trying to match [0]\ [21:51:50.8734] Slim::Control::Request::__parse (2395) ..no match for [0]\ [21:51:50.8737] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:50.8739] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:51:50.8741] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:51:50.8744] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, 0]\ [21:51:50.8746] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:51:50.8749] Slim::Control::Request::__parse (2387) ..Trying to match [200]\ [21:51:50.8751] Slim::Control::Request::__parse (2395) ..no match for [200]\ [21:51:50.8753] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:50.8756] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:51:50.8758] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:51:50.8760] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 200]\ [21:51:50.8763] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:51:50.8767] Slim::Control::Request::execute (1754) Enter\ [21:51:50.8769] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->rhapsodydirect items] from /85506c45/slim/request|49| (Dispatchable)\ [21:51:50.8772] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:51:50.8774] Slim::Control::Request::dump (2260) Param: [_quantity] = [200]\ [21:51:50.8778] Slim::Control::Request::dump (2260) Param: [menu] = [rhapsodydirect]\ [21:51:50.8780] Slim::Control::Request::dump (2260) Param: [item_id] = [1.2.8]\ [21:51:50.8853] Slim::Web::Cometd::handleRequest (800) Request for /85506c45/slim/request / 49 is async, will callback\ [21:51:50.8861] Slim::Web::Cometd::sendHTTPResponse (657) Sending Cometd Response:\ HTTP/1.1 200 OK\ Cache-Control: no-cache\ Pragma: no-cache\ Transfer-Encoding: chunked\ Content-Type: application/json\ Expires: -1\ \ [\{"timestamp":"Fri, 11 Jul 2008 20:51:50 GMT","channel":"/meta/reconnect","successful":true\},\{"clientId":"85506c45","id":"49","channel":"/slim/request","successful":true\}]\ [21:51:50.8870] Slim::Web::HTTP::sendResponse (1748) Sent 386 to 192.168.1.73:39410\ [21:51:50.8873] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 192.168.1.73:39410\ [21:51:50.8878] Slim::Web::HTTP::sendResponse (1706) No segment to send to 192.168.1.73:39410, waiting for next request...\ [21:51:51.3572] Slim::Web::HTTP::acceptHTTP (259) Accepted connection 4 from 127.0.0.1:54364\ [21:51:51.3579] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:51:51.3589] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54364 (Slim::Web::HTTP::ClientConn=GLOB(0x57b3478)) for POST HTTP/1.1 /jsonrpc.js\ [21:51:51.3597] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:51:51.3605] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:51:51.3608] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:51:51.3612] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:51:51.3615] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:51:51.3617] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:51:51.3620] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:51:51.3622] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:51:51.3625] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:51.3632] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:51:51.3634] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:51:51.3637] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:51:51.3639] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:51:51.3641] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:51:51.3644] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:51:51.3646] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:51.3648] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:51:51.3650] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:51:51.3652] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:51:51.3655] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:51:51.3658] Slim::Control::Request::execute (1754) Enter\ [21:51:51.3661] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:51:51.3663] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:51:51.3666] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:51:51.3689] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:51:51.3692] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:51:51.3794] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:51:51.3800] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:51:51.3803] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:51:51.3812] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:51:51.3815] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:51:51.3818] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:51:51.3820] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45753]\ [21:51:51.3823] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:51:51.3825] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:51:51.3829] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:51:51.3832] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:51:51.3836] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:51:51.3839] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:51:51.3842] Slim::Control::Request::executeDone (1822) 0\ [21:51:51.3854] Slim::Web::HTTP::acceptHTTP (259) Accepted connection 5 from 127.0.0.1:54365\ [21:51:51.3860] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:51:51.3869] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54365 (Slim::Web::HTTP::ClientConn=GLOB(0x572dda4)) for POST HTTP/1.1 /jsonrpc.js\ [21:51:51.3874] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 69\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["",["serverstatus",0,999]]\}\ ]\ [21:51:51.3879] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:51:51.3883] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:51:51.3888] Slim::Control::Request::__parse (2367) Request: parse(serverstatus 0 999)\ [21:51:51.3890] Slim::Control::Request::__parse (2387) ..Trying to match [serverstatus]\ [21:51:51.3893] Slim::Control::Request::__parse (2472) ..[serverstatus] is HASH\ [21:51:51.3895] Slim::Control::Request::__parse (2387) ..Trying to match [0]\ [21:51:51.3897] Slim::Control::Request::__parse (2395) ..no match for [0]\ [21:51:51.3899] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:51.3921] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:51:51.3924] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:51:51.3927] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, 0]\ [21:51:51.3929] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:51:51.3932] Slim::Control::Request::__parse (2387) ..Trying to match [999]\ [21:51:51.3935] Slim::Control::Request::__parse (2395) ..no match for [999]\ [21:51:51.3937] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:51.3939] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:51:51.3941] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:51:51.3943] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 999]\ [21:51:51.3946] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:51:51.3949] Slim::Control::Request::execute (1754) Enter\ [21:51:51.3951] Slim::Control::Request::dump (2256) Request: Query [serverstatus] from JSONRPC (Dispatchable)\ [21:51:51.3953] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:51:51.3957] Slim::Control::Request::dump (2260) Param: [_quantity] = [999]\ [21:51:51.3961] Slim::Control::Queries::serverstatusQuery (2917) serverstatusQuery()\ [21:51:51.4091] Slim::Control::Request::dump (2256) Request: Query [serverstatus] from JSONRPC (Done)\ [21:51:51.4096] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:51:51.4099] Slim::Control::Request::dump (2260) Param: [_quantity] = [999]\ [21:51:51.4103] Slim::Control::Request::dump (2282) Result: [version] = [7.1]\ [21:51:51.4107] Slim::Control::Request::dump (2282) Result: [info total albums] = [156]\ [21:51:51.4110] Slim::Control::Request::dump (2282) Result: [info total artists] = [398]\ [21:51:51.4113] Slim::Control::Request::dump (2282) Result: [info total genres] = [32]\ [21:51:51.4115] Slim::Control::Request::dump (2282) Result: [info total songs] = [1769]\ [21:51:51.4118] Slim::Control::Request::dump (2282) Result: [player count] = [1]\ [21:51:51.4121] Slim::Control::Request::dump (2269) Result: [players_loop] is loop with 1 elements:\ [21:51:51.4124] Slim::Control::Request::dump (2277) Result: 0. [playerid] = [00:04:20:16:06:17]\ [21:51:51.4128] Slim::Control::Request::dump (2277) Result: 0. [uuid] = [de2d825317cb52f96676afe3f0694635]\ [21:51:51.4130] Slim::Control::Request::dump (2277) Result: 0. [ip] = [192.168.1.70:45753]\ [21:51:51.4132] Slim::Control::Request::dump (2277) Result: 0. [name] = [Ray]\ [21:51:51.4136] Slim::Control::Request::dump (2277) Result: 0. [model] = [receiver]\ [21:51:51.4139] Slim::Control::Request::dump (2277) Result: 0. [power] = [1]\ [21:51:51.4142] Slim::Control::Request::dump (2277) Result: 0. [displaytype] = [none]\ [21:51:51.4145] Slim::Control::Request::dump (2277) Result: 0. [canpoweroff] = [1]\ [21:51:51.4147] Slim::Control::Request::dump (2277) Result: 0. [connected] = [1]\ [21:51:51.4150] Slim::Control::Request::dump (2277) Result: 0. [isplayer] = [1]\ [21:51:51.4154] Slim::Control::Request::dump (2282) Result: [sn player count] = [0]\ [21:51:51.4161] Slim::Control::Request::dump (2282) Result: [other player count] = [4]\ [21:51:51.4165] Slim::Control::Request::dump (2269) Result: [other_players_loop] is loop with 4 elements:\ [21:51:51.4168] Slim::Control::Request::dump (2277) Result: 0. [playerid] = [00:04:20:06:17:4c]\ [21:51:51.4171] Slim::Control::Request::dump (2277) Result: 0. [name] = [Kitchen]\ [21:51:51.4173] Slim::Control::Request::dump (2277) Result: 0. [model] = [squeezebox2]\ [21:51:51.4177] Slim::Control::Request::dump (2277) Result: 0. [server] = [harrypotter]\ [21:51:51.4179] Slim::Control::Request::dump (2277) Result: 0. [serverurl] = [http://harrypotter:9000/]\ [21:51:51.4183] Slim::Control::Request::dump (2277) Result: 1. [playerid] = [00:04:20:1e:00:8c]\ [21:51:51.4186] Slim::Control::Request::dump (2277) Result: 1. [name] = [Bedroom]\ [21:51:51.4189] Slim::Control::Request::dump (2277) Result: 1. [model] = [boom]\ [21:51:51.4193] Slim::Control::Request::dump (2277) Result: 1. [server] = [harrypotter]\ [21:51:51.4198] Slim::Control::Request::dump (2277) Result: 1. [serverurl] = [http://harrypotter:9000/]\ [21:51:51.4200] Slim::Control::Request::dump (2277) Result: 2. [playerid] = [00:04:20:10:00:02]\ [21:51:51.4203] Slim::Control::Request::dump (2277) Result: 2. [name] = [Transporter]\ [21:51:51.4206] Slim::Control::Request::dump (2277) Result: 2. [model] = [transporter]\ [21:51:51.4208] Slim::Control::Request::dump (2277) Result: 2. [server] = [harrypotter]\ [21:51:51.4211] Slim::Control::Request::dump (2277) Result: 2. [serverurl] = [http://harrypotter:9000/]\ [21:51:51.4214] Slim::Control::Request::dump (2277) Result: 3. [playerid] = [00:04:20:1e:00:12]\ [21:51:51.4218] Slim::Control::Request::dump (2277) Result: 3. [name] = [Squeezebox 4]\ [21:51:51.4221] Slim::Control::Request::dump (2277) Result: 3. [model] = [boom]\ [21:51:51.4223] Slim::Control::Request::dump (2277) Result: 3. [server] = [harrypotter]\ [21:51:51.4226] Slim::Control::Request::dump (2277) Result: 3. [serverurl] = [http://harrypotter:9000/]\ [21:51:51.4229] Slim::Control::Request::executeDone (1822) 0\ [21:51:51.4246] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54364\ [21:51:51.4248] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54364\ [21:51:51.4255] Slim::Web::HTTP::sendResponse (1748) Sent 1215 to 127.0.0.1:54365\ [21:51:51.4257] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54365\ [21:51:51.4261] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54364, waiting for next request...\ [21:51:51.4267] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54365, waiting for next request...\ [21:51:52.4429] Slim::Control::Request::notifyFromArray (799) (client disconnect)\ [21:51:52.4436] Slim::Control::Request::__parse (2367) Request: parse(client disconnect)\ [21:51:52.4440] Slim::Control::Request::__parse (2387) ..Trying to match [client]\ [21:51:52.4443] Slim::Control::Request::__parse (2472) ..[client] is HASH\ [21:51:52.4447] Slim::Control::Request::__parse (2387) ..Trying to match [disconnect]\ [21:51:52.4451] Slim::Control::Request::__parse (2453) ..[disconnect] is ARRAY -> done\ [21:51:52.4468] Slim::Control::Request::notifyFromArray (799) (client reconnect)\ [21:51:52.4472] Slim::Control::Request::__parse (2367) Request: parse(client reconnect)\ [21:51:52.4476] Slim::Control::Request::__parse (2387) ..Trying to match [client]\ [21:51:52.4479] Slim::Control::Request::__parse (2472) ..[client] is HASH\ [21:51:52.4483] Slim::Control::Request::__parse (2387) ..Trying to match [reconnect]\ [21:51:52.4486] Slim::Control::Request::__parse (2453) ..[reconnect] is ARRAY -> done\ [21:51:52.4491] Slim::Player::Squeezebox::needsUpgrade (415) Reading firmware version file: /Users/richardtitmuss/Documents/slimserver/server/Firmware/receiver.version\ [21:51:52.4496] Slim::Player::Squeezebox::needsUpgrade (472) receiver firmware is up-to-date, v. 23\ [21:51:52.4503] Slim::Control::Request::notify (1921) Notifying client disconnect\ [21:51:52.4508] Slim::Control::Request::notify (1953) Don't notify Slim::Player::Playlist::modifyPlaylistCallback of client disconnect !~ [['playlist']]\ [21:51:52.4512] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::Stats::newsongCallback of client disconnect !~ [['playlist']['newsong']]\ [21:51:52.4516] Slim::Control::Request::notify (1963) Notifying Slim::Networking::SqueezeNetwork::Players::__ANON__ of client disconnect =~ [['client']['disconnect','forget']]\ [21:51:52.4521] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::Favorites::OpmlFavorites::__ANON__ of client disconnect !~ [['rescan','done']]\ [21:51:52.4525] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::RandomPlay::Plugin::commandCallback of client disconnect !~ [['playlist']['newsong','delete','loadalbum','playtracks','playalbum','clear','play','loadtracks','load']]\ [21:51:52.4528] Slim::Control::Request::notify (1953) Don't notify Slim::Web::Cometd::__ANON__ of client disconnect !~ [['menustatus']]\ [21:51:52.4533] Slim::Control::Request::notify (1963) Notifying Slim::Networking::Discovery::Players::__ANON__ of client disconnect =~ [['client']['disconnect','forget']]\ [21:51:52.4537] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::AudioScrobbler::Plugin::newsongCallback of client disconnect !~ [['playlist']['newsong']]\ [21:51:52.4540] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::RandomPlay::Plugin::generateGenreNameMap of client disconnect !~ [['rescan']['done']]\ [21:51:52.4544] Slim::Control::Request::notify (1953) Don't notify Slim::Web::Cometd::__ANON__ of client disconnect !~ [['menustatus']]\ [21:51:52.4548] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::Players::fetch_players of client disconnect !~ [['client']['new','reconnect']]\ [21:51:52.4552] Slim::Control::Request::notify (1953) Don't notify Slim::Buttons::Playlist::knobPlaylistCallback of client disconnect !~ [['playlist']]\ [21:51:52.4556] Slim::Control::Request::notify (1953) Don't notify Slim::Control::Jive::menuNotification of client disconnect !~ [['menustatus']]\ [21:51:52.4560] Slim::Control::Request::notify (1953) Don't notify Slim::Control::Jive::buildCaches of client disconnect !~ [['rescan','done']]\ [21:51:52.4564] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::Discovery::Server::fetch_servers of client disconnect !~ [['client']['new','reconnect']]\ [21:51:52.4568] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::PrefSync::prefEvent of client disconnect !~ [['prefset']]\ [21:51:52.4572] Slim::Control::Request::notify (1963) Notifying Slim::Networking::SqueezeNetwork::PrefSync::clientEvent of client disconnect =~ [['client']['new','reconnect','disconnect']]\ [21:51:52.4584] Slim::Utils::Firmware::jive_needs_upgrade (313) Jive doesn't need an upgrade (has: 7.1 r2679M, server has: 7.1 2679)\ [21:51:52.4589] Slim::Control::Request::registerAutoExecute (2038) registerAutoExecute()\ [21:51:52.4593] Slim::Control::Request::registerAutoExecute (2066) Old friend: 85506c45 - firmwareupgrade - 00:04:20:16:06:17\ [21:51:52.4597] Slim::Control::Request::registerAutoExecute (2086) .. set ourself up\ [21:51:52.4625] Slim::Control::Request::notify (1921) Notifying client reconnect\ [21:51:52.4629] Slim::Control::Request::notify (1953) Don't notify Slim::Player::Playlist::modifyPlaylistCallback of client reconnect !~ [['playlist']]\ [21:51:52.4632] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::Stats::newsongCallback of client reconnect !~ [['playlist']['newsong']]\ [21:51:52.4636] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::Players::__ANON__ of client reconnect !~ [['client']['disconnect','forget']]\ [21:51:52.4640] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::Favorites::OpmlFavorites::__ANON__ of client reconnect !~ [['rescan','done']]\ [21:51:52.4644] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::RandomPlay::Plugin::commandCallback of client reconnect !~ [['playlist']['newsong','delete','loadalbum','playtracks','playalbum','clear','play','loadtracks','load']]\ [21:51:52.4648] Slim::Control::Request::notify (1953) Don't notify Slim::Web::Cometd::__ANON__ of client reconnect !~ [['menustatus']]\ [21:51:52.4652] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::Discovery::Players::__ANON__ of client reconnect !~ [['client']['disconnect','forget']]\ [21:51:52.4656] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::AudioScrobbler::Plugin::newsongCallback of client reconnect !~ [['playlist']['newsong']]\ [21:51:52.4660] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::RandomPlay::Plugin::generateGenreNameMap of client reconnect !~ [['rescan']['done']]\ [21:51:52.4663] Slim::Control::Request::notify (1953) Don't notify Slim::Web::Cometd::__ANON__ of client reconnect !~ [['menustatus']]\ [21:51:52.4667] Slim::Control::Request::notify (1963) Notifying Slim::Networking::SqueezeNetwork::Players::fetch_players of client reconnect =~ [['client']['new','reconnect']]\ [21:51:52.4697] Slim::Control::Request::notify (1953) Don't notify Slim::Buttons::Playlist::knobPlaylistCallback of client reconnect !~ [['playlist']]\ [21:51:52.4701] Slim::Control::Request::notify (1953) Don't notify Slim::Control::Jive::menuNotification of client reconnect !~ [['menustatus']]\ [21:51:52.4705] Slim::Control::Request::notify (1953) Don't notify Slim::Control::Jive::buildCaches of client reconnect !~ [['rescan','done']]\ [21:51:52.4711] Slim::Control::Request::notify (1963) Notifying Slim::Networking::Discovery::Server::fetch_servers of client reconnect =~ [['client']['new','reconnect']]\ [21:51:52.4719] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::PrefSync::prefEvent of client reconnect !~ [['prefset']]\ [21:51:52.4724] Slim::Control::Request::notify (1963) Notifying Slim::Networking::SqueezeNetwork::PrefSync::clientEvent of client reconnect =~ [['client']['new','reconnect','disconnect']]\ [21:51:52.4761] Slim::Utils::Firmware::jive_needs_upgrade (313) Jive doesn't need an upgrade (has: 7.1 r2679M, server has: 7.1 2679)\ [21:51:52.4767] Slim::Control::Request::registerAutoExecute (2038) registerAutoExecute()\ [21:51:52.4771] Slim::Control::Request::registerAutoExecute (2066) Old friend: 85506c45 - firmwareupgrade - 00:04:20:16:06:17\ [21:51:52.4776] Slim::Control::Request::registerAutoExecute (2086) .. set ourself up\ [21:51:52.5449] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:51:52.5456] Slim::Web::HTTP::processHTTP (368) Client at 192.168.1.73: disconnected. (sysread: Connection reset by peer)\ [21:51:52.5460] Slim::Web::HTTP::closeHTTPSocket (2519) Closing HTTP socket Slim::Web::HTTP::ClientConn=GLOB(0x57b4ad0) with 192.168.1.73:0 (sysread: Connection reset by peer)\ [21:51:52.5468] Slim::Web::Cometd::webCloseHandler (879) Lost connection from :, clid: 85506c45, transport: streaming\ [21:51:52.5473] Slim::Web::Cometd::Manager::remove_connection (63) remove_connection: 85506c45\ [21:51:52.6118] Slim::Control::Request::notifyFromArray (799) (prefset server snLastSyncDown 1215809519)\ [21:51:52.6123] Slim::Control::Request::__parse (2367) Request: parse(prefset server snLastSyncDown 1215809519)\ [21:51:52.6126] Slim::Control::Request::__parse (2387) ..Trying to match [prefset]\ [21:51:52.6129] Slim::Control::Request::__parse (2472) ..[prefset] is HASH\ [21:51:52.6133] Slim::Control::Request::__parse (2387) ..Trying to match [server]\ [21:51:52.6136] Slim::Control::Request::__parse (2395) ..no match for [server]\ [21:51:52.6139] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:52.6142] Slim::Control::Request::__parse (2417) ....considering [_namespace]\ [21:51:52.6146] Slim::Control::Request::__parse (2423) ....[_namespace] starts with _\ [21:51:52.6149] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_namespace, server]\ [21:51:52.6153] Slim::Control::Request::__parse (2472) ..[_namespace] is HASH\ [21:51:52.6156] Slim::Control::Request::__parse (2387) ..Trying to match [snLastSyncDown]\ [21:51:52.6159] Slim::Control::Request::__parse (2395) ..no match for [snLastSyncDown]\ [21:51:52.6162] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:52.6166] Slim::Control::Request::__parse (2417) ....considering [_prefname]\ [21:51:52.6169] Slim::Control::Request::__parse (2423) ....[_prefname] starts with _\ [21:51:52.6172] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_prefname, snLastSyncDown]\ [21:51:52.6176] Slim::Control::Request::__parse (2472) ..[_prefname] is HASH\ [21:51:52.6179] Slim::Control::Request::__parse (2387) ..Trying to match [1215809519]\ [21:51:52.6183] Slim::Control::Request::__parse (2395) ..no match for [1215809519]\ [21:51:52.6187] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:52.6190] Slim::Control::Request::__parse (2417) ....considering [_newvalue]\ [21:51:52.6193] Slim::Control::Request::__parse (2423) ....[_newvalue] starts with _\ [21:51:52.6196] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_newvalue, 1215809519]\ [21:51:52.6200] Slim::Control::Request::__parse (2453) ..[_newvalue] is ARRAY -> done\ [21:51:52.6204] Slim::Control::Request::notifyFromArray (799) (prefset server snSyncInterval 403870)\ [21:51:52.6207] Slim::Control::Request::__parse (2367) Request: parse(prefset server snSyncInterval 403870)\ [21:51:52.6211] Slim::Control::Request::__parse (2387) ..Trying to match [prefset]\ [21:51:52.6214] Slim::Control::Request::__parse (2472) ..[prefset] is HASH\ [21:51:52.6217] Slim::Control::Request::__parse (2387) ..Trying to match [server]\ [21:51:52.6221] Slim::Control::Request::__parse (2395) ..no match for [server]\ [21:51:52.6224] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:52.6228] Slim::Control::Request::__parse (2417) ....considering [_namespace]\ [21:51:52.6232] Slim::Control::Request::__parse (2423) ....[_namespace] starts with _\ [21:51:52.6235] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_namespace, server]\ [21:51:52.6238] Slim::Control::Request::__parse (2472) ..[_namespace] is HASH\ [21:51:52.6242] Slim::Control::Request::__parse (2387) ..Trying to match [snSyncInterval]\ [21:51:52.6245] Slim::Control::Request::__parse (2395) ..no match for [snSyncInterval]\ [21:51:52.6248] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:52.6251] Slim::Control::Request::__parse (2417) ....considering [_prefname]\ [21:51:52.6255] Slim::Control::Request::__parse (2423) ....[_prefname] starts with _\ [21:51:52.6258] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_prefname, snSyncInterval]\ [21:51:52.6261] Slim::Control::Request::__parse (2472) ..[_prefname] is HASH\ [21:51:52.6264] Slim::Control::Request::__parse (2387) ..Trying to match [403870]\ [21:51:52.6268] Slim::Control::Request::__parse (2395) ..no match for [403870]\ [21:51:52.6271] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:52.6274] Slim::Control::Request::__parse (2417) ....considering [_newvalue]\ [21:51:52.6277] Slim::Control::Request::__parse (2423) ....[_newvalue] starts with _\ [21:51:52.6280] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_newvalue, 403870]\ [21:51:52.6284] Slim::Control::Request::__parse (2453) ..[_newvalue] is ARRAY -> done\ [21:51:52.6290] Slim::Control::Request::notify (1921) Notifying prefset\ [21:51:52.6295] Slim::Control::Request::notify (1953) Don't notify Slim::Player::Playlist::modifyPlaylistCallback of prefset !~ [['playlist']]\ [21:51:52.6298] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::Stats::newsongCallback of prefset !~ [['playlist']['newsong']]\ [21:51:52.6302] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::Players::__ANON__ of prefset !~ [['client']['disconnect','forget']]\ [21:51:52.6306] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::Favorites::OpmlFavorites::__ANON__ of prefset !~ [['rescan','done']]\ [21:51:52.6310] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::RandomPlay::Plugin::commandCallback of prefset !~ [['playlist']['newsong','delete','loadalbum','playtracks','playalbum','clear','play','loadtracks','load']]\ [21:51:52.6314] Slim::Control::Request::notify (1953) Don't notify Slim::Web::Cometd::__ANON__ of prefset !~ [['menustatus']]\ [21:51:52.6318] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::Discovery::Players::__ANON__ of prefset !~ [['client']['disconnect','forget']]\ [21:51:52.6321] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::AudioScrobbler::Plugin::newsongCallback of prefset !~ [['playlist']['newsong']]\ [21:51:52.6325] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::RandomPlay::Plugin::generateGenreNameMap of prefset !~ [['rescan']['done']]\ [21:51:52.6329] Slim::Control::Request::notify (1953) Don't notify Slim::Web::Cometd::__ANON__ of prefset !~ [['menustatus']]\ [21:51:52.6333] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::Players::fetch_players of prefset !~ [['client']['new','reconnect']]\ [21:51:52.6337] Slim::Control::Request::notify (1953) Don't notify Slim::Buttons::Playlist::knobPlaylistCallback of prefset !~ [['playlist']]\ [21:51:52.6340] Slim::Control::Request::notify (1953) Don't notify Slim::Control::Jive::menuNotification of prefset !~ [['menustatus']]\ [21:51:52.6345] Slim::Control::Request::notify (1953) Don't notify Slim::Control::Jive::buildCaches of prefset !~ [['rescan','done']]\ [21:51:52.6349] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::Discovery::Server::fetch_servers of prefset !~ [['client']['new','reconnect']]\ [21:51:52.6353] Slim::Control::Request::notify (1963) Notifying Slim::Networking::SqueezeNetwork::PrefSync::prefEvent of prefset =~ [['prefset']]\ [21:51:52.6358] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::PrefSync::clientEvent of prefset !~ [['client']['new','reconnect','disconnect']]\ [21:51:52.6367] Slim::Utils::Firmware::jive_needs_upgrade (313) Jive doesn't need an upgrade (has: 7.1 r2679M, server has: 7.1 2679)\ [21:51:52.6371] Slim::Control::Request::registerAutoExecute (2038) registerAutoExecute()\ [21:51:52.6375] Slim::Control::Request::registerAutoExecute (2066) Old friend: 85506c45 - firmwareupgrade - 00:04:20:16:06:17\ [21:51:52.6380] Slim::Control::Request::registerAutoExecute (2086) .. set ourself up\ [21:51:52.6390] Slim::Control::Request::notify (1921) Notifying prefset\ [21:51:52.6394] Slim::Control::Request::notify (1953) Don't notify Slim::Player::Playlist::modifyPlaylistCallback of prefset !~ [['playlist']]\ [21:51:52.6399] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::Stats::newsongCallback of prefset !~ [['playlist']['newsong']]\ [21:51:52.6403] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::Players::__ANON__ of prefset !~ [['client']['disconnect','forget']]\ [21:51:52.6406] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::Favorites::OpmlFavorites::__ANON__ of prefset !~ [['rescan','done']]\ [21:51:52.6410] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::RandomPlay::Plugin::commandCallback of prefset !~ [['playlist']['newsong','delete','loadalbum','playtracks','playalbum','clear','play','loadtracks','load']]\ [21:51:52.6414] Slim::Control::Request::notify (1953) Don't notify Slim::Web::Cometd::__ANON__ of prefset !~ [['menustatus']]\ [21:51:52.6418] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::Discovery::Players::__ANON__ of prefset !~ [['client']['disconnect','forget']]\ [21:51:52.6422] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::AudioScrobbler::Plugin::newsongCallback of prefset !~ [['playlist']['newsong']]\ [21:51:52.6425] Slim::Control::Request::notify (1953) Don't notify Slim::Plugin::RandomPlay::Plugin::generateGenreNameMap of prefset !~ [['rescan']['done']]\ [21:51:52.6429] Slim::Control::Request::notify (1953) Don't notify Slim::Web::Cometd::__ANON__ of prefset !~ [['menustatus']]\ [21:51:52.6433] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::Players::fetch_players of prefset !~ [['client']['new','reconnect']]\ [21:51:52.6437] Slim::Control::Request::notify (1953) Don't notify Slim::Buttons::Playlist::knobPlaylistCallback of prefset !~ [['playlist']]\ [21:51:52.6440] Slim::Control::Request::notify (1953) Don't notify Slim::Control::Jive::menuNotification of prefset !~ [['menustatus']]\ [21:51:52.6444] Slim::Control::Request::notify (1953) Don't notify Slim::Control::Jive::buildCaches of prefset !~ [['rescan','done']]\ [21:51:52.6448] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::Discovery::Server::fetch_servers of prefset !~ [['client']['new','reconnect']]\ [21:51:52.6452] Slim::Control::Request::notify (1963) Notifying Slim::Networking::SqueezeNetwork::PrefSync::prefEvent of prefset =~ [['prefset']]\ [21:51:52.6457] Slim::Control::Request::notify (1953) Don't notify Slim::Networking::SqueezeNetwork::PrefSync::clientEvent of prefset !~ [['client']['new','reconnect','disconnect']]\ [21:51:52.6465] Slim::Utils::Firmware::jive_needs_upgrade (313) Jive doesn't need an upgrade (has: 7.1 r2679M, server has: 7.1 2679)\ [21:51:52.6469] Slim::Control::Request::registerAutoExecute (2038) registerAutoExecute()\ [21:51:52.6472] Slim::Control::Request::registerAutoExecute (2066) Old friend: 85506c45 - firmwareupgrade - 00:04:20:16:06:17\ [21:51:52.6478] Slim::Control::Request::registerAutoExecute (2086) .. set ourself up\ [21:51:52.7787] Slim::Control::Request::__autoexecute (2534) __autoexecute()\ [21:51:52.7793] Slim::Control::Request::execute (1754) Enter\ [21:51:52.7798] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from /85506c45/slim/playerstatus/00:04:20:16:06:17|4| (Dispatchable)\ [21:51:52.7804] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:51:52.7808] Slim::Control::Request::dump (2260) Param: [_quantity] = [10]\ [21:51:52.7812] Slim::Control::Request::dump (2260) Param: [menu] = [menu]\ [21:51:52.7816] Slim::Control::Request::dump (2260) Param: [subscribe] = [30]\ [21:51:52.7821] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:51:52.7855] Slim::Control::Queries::statusQuery (3371) statusQuery(): setup base for jive\ [21:51:52.7860] Slim::Control::Queries::statusQuery (3510) statusQuery(): setting up subscription\ [21:51:52.7863] Slim::Control::Request::registerAutoExecute (2038) registerAutoExecute()\ [21:51:52.7867] Slim::Control::Request::registerAutoExecute (2066) Old friend: 85506c45 - status - 00:04:20:16:06:17\ [21:51:52.7873] Slim::Control::Request::registerAutoExecute (2086) .. set ourself up\ [21:51:52.7879] Slim::Control::Request::registerAutoExecute (2094) .. starting timer: 30\ [21:51:52.7883] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from /85506c45/slim/playerstatus/00:04:20:16:06:17|4| (Done)\ [21:51:52.7886] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:51:52.7890] Slim::Control::Request::dump (2260) Param: [_quantity] = [10]\ [21:51:52.7893] Slim::Control::Request::dump (2260) Param: [menu] = [menu]\ [21:51:52.7897] Slim::Control::Request::dump (2260) Param: [subscribe] = [30]\ [21:51:52.7900] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:51:52.7903] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:51:52.7907] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:51:52.7910] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:51:52.7914] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:51:52.7917] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:51:52.7920] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:51:52.7924] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:51:52.7927] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:51:52.7931] Slim::Control::Request::dump (2282) Result: [count] = [0]\ [21:51:52.7934] Slim::Control::Request::dump (2282) Result: [base] = [HASH(0x56ab218)]\ [21:51:52.7937] Slim::Control::Request::executeDone (1822) 0\ [21:51:52.7941] Slim::Web::Cometd::requestCallback (832) requestCallback got results for /85506c45/slim/playerstatus/00:04:20:16:06:17 / 4\ [21:51:52.7945] Slim::Web::Cometd::Manager::deliver_events (209) Sending event on channel /85506c45/slim/playerstatus/00:04:20:16:06:17 to 85506c45\ [21:51:52.7948] Slim::Web::Cometd::Manager::deliver_events (236) Queued 1 event(s) for 85506c45\ [21:51:52.7953] Slim::Control::Request::__autoexecute (2534) __autoexecute()\ [21:51:52.7957] Slim::Control::Request::execute (1754) Enter\ [21:51:52.7960] Slim::Control::Request::dump (2256) Request: Query [serverstatus] from /85506c45/slim/serverstatus|1| (Dispatchable)\ [21:51:52.7964] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:51:52.7967] Slim::Control::Request::dump (2260) Param: [_quantity] = [50]\ [21:51:52.7970] Slim::Control::Request::dump (2260) Param: [subscribe] = [60]\ [21:51:52.7974] Slim::Control::Queries::serverstatusQuery (2917) serverstatusQuery()\ [21:51:52.8127] Slim::Control::Request::registerAutoExecute (2038) registerAutoExecute()\ [21:51:52.8131] Slim::Control::Request::registerAutoExecute (2066) Old friend: 85506c45 - serverstatus - global\ [21:51:52.8136] Slim::Control::Request::registerAutoExecute (2086) .. set ourself up\ [21:51:52.8141] Slim::Control::Request::registerAutoExecute (2094) .. starting timer: 60\ [21:51:52.8145] Slim::Control::Request::dump (2256) Request: Query [serverstatus] from /85506c45/slim/serverstatus|1| (Done)\ [21:51:52.8147] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:51:52.8150] Slim::Control::Request::dump (2260) Param: [_quantity] = [50]\ [21:51:52.8153] Slim::Control::Request::dump (2260) Param: [subscribe] = [60]\ [21:51:52.8163] Slim::Control::Request::dump (2282) Result: [version] = [7.1]\ [21:51:52.8165] Slim::Control::Request::dump (2282) Result: [info total albums] = [156]\ [21:51:52.8168] Slim::Control::Request::dump (2282) Result: [info total artists] = [398]\ [21:51:52.8171] Slim::Control::Request::dump (2282) Result: [info total genres] = [32]\ [21:51:52.8174] Slim::Control::Request::dump (2282) Result: [info total songs] = [1769]\ [21:51:52.8177] Slim::Control::Request::dump (2282) Result: [player count] = [1]\ [21:51:52.8180] Slim::Control::Request::dump (2269) Result: [players_loop] is loop with 1 elements:\ [21:51:52.8183] Slim::Control::Request::dump (2277) Result: 0. [playerid] = [00:04:20:16:06:17]\ [21:51:52.8186] Slim::Control::Request::dump (2277) Result: 0. [uuid] = [de2d825317cb52f96676afe3f0694635]\ [21:51:52.8189] Slim::Control::Request::dump (2277) Result: 0. [ip] = [192.168.1.70:45918]\ [21:51:52.8191] Slim::Control::Request::dump (2277) Result: 0. [name] = [Ray]\ [21:51:52.8194] Slim::Control::Request::dump (2277) Result: 0. [model] = [receiver]\ [21:51:52.8197] Slim::Control::Request::dump (2277) Result: 0. [power] = [1]\ [21:51:52.8199] Slim::Control::Request::dump (2277) Result: 0. [displaytype] = [none]\ [21:51:52.8202] Slim::Control::Request::dump (2277) Result: 0. [canpoweroff] = [1]\ [21:51:52.8205] Slim::Control::Request::dump (2277) Result: 0. [connected] = [1]\ [21:51:52.8207] Slim::Control::Request::dump (2277) Result: 0. [isplayer] = [1]\ [21:51:52.8210] Slim::Control::Request::dump (2282) Result: [sn player count] = [0]\ [21:51:52.8213] Slim::Control::Request::dump (2282) Result: [other player count] = [4]\ [21:51:52.8216] Slim::Control::Request::dump (2269) Result: [other_players_loop] is loop with 4 elements:\ [21:51:52.8219] Slim::Control::Request::dump (2277) Result: 0. [playerid] = [00:04:20:06:17:4c]\ [21:51:52.8222] Slim::Control::Request::dump (2277) Result: 0. [name] = [Kitchen]\ [21:51:52.8225] Slim::Control::Request::dump (2277) Result: 0. [model] = [squeezebox2]\ [21:51:52.8227] Slim::Control::Request::dump (2277) Result: 0. [server] = [harrypotter]\ [21:51:52.8230] Slim::Control::Request::dump (2277) Result: 0. [serverurl] = [http://192.168.1.1:9000/]\ [21:51:52.8233] Slim::Control::Request::dump (2277) Result: 1. [playerid] = [00:04:20:1e:00:8c]\ [21:51:52.8236] Slim::Control::Request::dump (2277) Result: 1. [name] = [Bedroom]\ [21:51:52.8239] Slim::Control::Request::dump (2277) Result: 1. [model] = [boom]\ [21:51:52.8241] Slim::Control::Request::dump (2277) Result: 1. [server] = [harrypotter]\ [21:51:52.8244] Slim::Control::Request::dump (2277) Result: 1. [serverurl] = [http://192.168.1.1:9000/]\ [21:51:52.8247] Slim::Control::Request::dump (2277) Result: 2. [playerid] = [00:04:20:10:00:02]\ [21:51:52.8249] Slim::Control::Request::dump (2277) Result: 2. [name] = [Transporter]\ [21:51:52.8252] Slim::Control::Request::dump (2277) Result: 2. [model] = [transporter]\ [21:51:52.8255] Slim::Control::Request::dump (2277) Result: 2. [server] = [harrypotter]\ [21:51:52.8257] Slim::Control::Request::dump (2277) Result: 2. [serverurl] = [http://192.168.1.1:9000/]\ [21:51:52.8260] Slim::Control::Request::dump (2277) Result: 3. [playerid] = [00:04:20:1e:00:12]\ [21:51:52.8263] Slim::Control::Request::dump (2277) Result: 3. [name] = [Squeezebox 4]\ [21:51:52.8266] Slim::Control::Request::dump (2277) Result: 3. [model] = [boom]\ [21:51:52.8268] Slim::Control::Request::dump (2277) Result: 3. [server] = [harrypotter]\ [21:51:52.8271] Slim::Control::Request::dump (2277) Result: 3. [serverurl] = [http://192.168.1.1:9000/]\ [21:51:52.8274] Slim::Control::Request::executeDone (1822) 0\ [21:51:52.8277] Slim::Web::Cometd::requestCallback (832) requestCallback got results for /85506c45/slim/serverstatus / 1\ [21:51:52.8280] Slim::Web::Cometd::Manager::deliver_events (209) Sending event on channel /85506c45/slim/serverstatus to 85506c45\ [21:51:52.8283] Slim::Web::Cometd::Manager::deliver_events (236) Queued 1 event(s) for 85506c45\ [21:51:54.3961] Slim::Control::Request::callback (1877) Calling callback function\ [21:51:54.3965] Slim::Web::Cometd::requestCallback (832) requestCallback got results for /85506c45/slim/request / 49\ [21:51:54.3969] Slim::Web::Cometd::Manager::deliver_events (209) Sending event on channel /85506c45/slim/request to 85506c45\ [21:51:54.3972] Slim::Web::Cometd::Manager::deliver_events (236) Queued 1 event(s) for 85506c45\ [21:51:54.3975] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->rhapsodydirect items] cb+ from /85506c45/slim/request|49| (Done)\ [21:51:54.3978] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:51:54.3981] Slim::Control::Request::dump (2260) Param: [_quantity] = [200]\ [21:51:54.3983] Slim::Control::Request::dump (2260) Param: [menu] = [rhapsodydirect]\ [21:51:54.3986] Slim::Control::Request::dump (2260) Param: [item_id] = [1.2.8]\ [21:51:54.3989] Slim::Control::Request::dump (2282) Result: [offset] = [0]\ [21:51:54.3992] Slim::Control::Request::dump (2282) Result: [title] = [The Rolling Stones]\ [21:51:54.3994] Slim::Control::Request::dump (2282) Result: [base] = [HASH(0x80e1368)]\ [21:51:54.3997] Slim::Control::Request::dump (2269) Result: [item_loop] is loop with 10 elements:\ [21:51:54.4000] Slim::Control::Request::dump (2277) Result: 0. [text] = [Albums]\ [21:51:54.4003] Slim::Control::Request::dump (2277) Result: 0. [actions] = [HASH(0x8071bb0)]\ [21:51:54.4005] Slim::Control::Request::dump (2277) Result: 0. [playAction] = [go]\ [21:51:54.4008] Slim::Control::Request::dump (2277) Result: 0. [addAction] = [go]\ [21:51:54.4011] Slim::Control::Request::dump (2277) Result: 1. [text] = [Singles]\ [21:51:54.4014] Slim::Control::Request::dump (2277) Result: 1. [actions] = [HASH(0x803e260)]\ [21:51:54.4016] Slim::Control::Request::dump (2277) Result: 1. [playAction] = [go]\ [21:51:54.4019] Slim::Control::Request::dump (2277) Result: 1. [addAction] = [go]\ [21:51:54.4022] Slim::Control::Request::dump (2277) Result: 2. [text] = [Compilations]\ [21:51:54.4024] Slim::Control::Request::dump (2277) Result: 2. [actions] = [HASH(0x57908f0)]\ [21:51:54.4027] Slim::Control::Request::dump (2277) Result: 2. [playAction] = [go]\ [21:51:54.4030] Slim::Control::Request::dump (2277) Result: 2. [addAction] = [go]\ [21:51:54.4033] Slim::Control::Request::dump (2277) Result: 3. [text] = [Artist Bio]\ [21:51:54.4035] Slim::Control::Request::dump (2277) Result: 3. [actions] = [HASH(0x80e4380)]\ [21:51:54.4038] Slim::Control::Request::dump (2277) Result: 3. [playAction] = [go]\ [21:51:54.4041] Slim::Control::Request::dump (2277) Result: 3. [addAction] = [go]\ [21:51:54.4043] Slim::Control::Request::dump (2277) Result: 4. [text] = [Top Albums]\ [21:51:54.4046] Slim::Control::Request::dump (2277) Result: 4. [actions] = [HASH(0x57f9030)]\ [21:51:54.4049] Slim::Control::Request::dump (2277) Result: 4. [playAction] = [go]\ [21:51:54.4051] Slim::Control::Request::dump (2277) Result: 4. [addAction] = [go]\ [21:51:54.4054] Slim::Control::Request::dump (2277) Result: 5. [text] = [Top Tracks]\ [21:51:54.4057] Slim::Control::Request::dump (2277) Result: 5. [params] = [HASH(0x4fd0b8)]\ [21:51:54.4060] Slim::Control::Request::dump (2277) Result: 6. [text] = [New Releases]\ [21:51:54.4062] Slim::Control::Request::dump (2277) Result: 6. [actions] = [HASH(0x567dd68)]\ [21:51:54.4065] Slim::Control::Request::dump (2277) Result: 6. [playAction] = [go]\ [21:51:54.4068] Slim::Control::Request::dump (2277) Result: 6. [addAction] = [go]\ [21:51:54.4071] Slim::Control::Request::dump (2277) Result: 7. [text] = [Artist Sampler]\ [21:51:54.4073] Slim::Control::Request::dump (2277) Result: 7. [params] = [HASH(0x5716260)]\ [21:51:54.4076] Slim::Control::Request::dump (2277) Result: 8. [text] = [The Rolling Stones Radio]\ [21:51:54.4079] Slim::Control::Request::dump (2277) Result: 8. [params] = [HASH(0x80604c4)]\ [21:51:54.4082] Slim::Control::Request::dump (2277) Result: 9. [text] = [Related Artists]\ [21:51:54.4085] Slim::Control::Request::dump (2277) Result: 9. [actions] = [HASH(0x572f538)]\ [21:51:54.4088] Slim::Control::Request::dump (2277) Result: 9. [playAction] = [go]\ [21:51:54.4091] Slim::Control::Request::dump (2277) Result: 9. [addAction] = [go]\ [21:51:54.4093] Slim::Control::Request::dump (2282) Result: [count] = [10]\ [21:51:54.4096] Slim::Control::Request::dump (2282) Result: [window] = [HASH(0x56a1834)]\ [21:51:54.4099] Slim::Control::Request::executeDone (1822) 0\ [21:51:56.4612] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:51:56.4625] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54364 (Slim::Web::HTTP::ClientConn=GLOB(0x57b3478)) for POST HTTP/1.1 /jsonrpc.js\ [21:51:56.4631] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:51:56.4640] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:51:56.4644] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:51:56.4650] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:51:56.4654] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:51:56.4657] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:51:56.4660] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:51:56.4663] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:51:56.4666] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:56.4670] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:51:56.4673] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:51:56.4676] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:51:56.4680] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:51:56.4683] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:51:56.4686] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:51:56.4689] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:51:56.4692] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:51:56.4695] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:51:56.4699] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:51:56.4702] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:51:56.4706] Slim::Control::Request::execute (1754) Enter\ [21:51:56.4710] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:51:56.4714] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:51:56.4718] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:51:56.4721] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:51:56.4725] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:51:56.4749] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:51:56.4754] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:51:56.4758] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:51:56.4761] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:51:56.4764] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:51:56.4768] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:51:56.4771] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:51:56.4775] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:51:56.4778] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:51:56.4782] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:51:56.4785] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:51:56.4789] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:51:56.4792] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:51:56.4795] Slim::Control::Request::executeDone (1822) 0\ [21:51:56.4810] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54364\ [21:51:56.4814] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54364\ [21:51:56.4821] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54364, waiting for next request...\ [21:52:01.5214] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:01.5227] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54365 (Slim::Web::HTTP::ClientConn=GLOB(0x572dda4)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:01.5233] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:52:01.5243] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:01.5246] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:01.5252] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:52:01.5256] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:52:01.5259] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:52:01.5262] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:52:01.5266] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:52:01.5269] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:01.5273] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:01.5276] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:01.5279] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:52:01.5282] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:01.5286] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:52:01.5289] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:52:01.5292] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:01.5295] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:01.5299] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:01.5302] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:52:01.5306] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:01.5310] Slim::Control::Request::execute (1754) Enter\ [21:52:01.5314] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:52:01.5317] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:01.5320] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:01.5324] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:01.5327] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:52:01.5351] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:52:01.5355] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:01.5359] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:01.5362] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:01.5365] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:52:01.5369] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:52:01.5372] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:52:01.5376] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:52:01.5379] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:52:01.5382] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:52:01.5386] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:52:01.5389] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:52:01.5393] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:52:01.5396] Slim::Control::Request::executeDone (1822) 0\ [21:52:01.5409] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54365\ [21:52:01.5413] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54365\ [21:52:01.5421] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54365, waiting for next request...\ [21:52:02.5481] Slim::Web::Cometd::disconnectClient (926) Disconnect for 85506c45, removing subscriptions\ [21:52:02.5502] Slim::Control::Queries::__ANON__ (1162) last listener - suppressing display notify\ [21:52:02.5507] Slim::Web::Cometd::disconnectClient (931) Unregistered all auto-execute requests for client 85506c45\ [21:52:02.5512] Slim::Control::Request::unsubscribe (784) Request from: Slim::Web::Cometd::__ANON__ - (16 listeners)\ [21:52:02.5515] Slim::Web::Cometd::disconnectClient (939) Unsubscribed from callback CODE(0x570f108) for /85506c45/slim/menustatus/00:04:20:16:06:17\ [21:52:02.5524] Slim::Web::Cometd::Manager::remove_channels (137) remove_channels for 85506c45: (?-xism:^/85506c45/)\ [21:52:02.5528] Slim::Web::Cometd::Manager::remove_client (88) remove_client: 85506c45\ [21:52:06.5809] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:06.5822] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54364 (Slim::Web::HTTP::ClientConn=GLOB(0x57b3478)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:06.5828] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:52:06.5838] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:06.5842] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:06.5848] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:52:06.5851] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:52:06.5854] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:52:06.5858] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:52:06.5861] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:52:06.5864] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:06.5867] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:06.5870] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:06.5874] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:52:06.5877] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:06.5880] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:52:06.5884] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:52:06.5887] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:06.5890] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:06.5893] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:06.5896] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:52:06.5900] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:06.5904] Slim::Control::Request::execute (1754) Enter\ [21:52:06.5908] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:52:06.5911] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:06.5915] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:06.5918] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:06.5922] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:52:06.5945] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:52:06.5949] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:06.5952] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:06.5956] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:06.5959] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:52:06.5963] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:52:06.5967] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:52:06.5971] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:52:06.5974] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:52:06.5978] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:52:06.5982] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:52:06.5985] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:52:06.5989] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:52:06.5992] Slim::Control::Request::executeDone (1822) 0\ [21:52:06.6005] Slim::Web::HTTP::sendResponse (1748) Sent 452 to 127.0.0.1:54364\ [21:52:06.6010] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54364\ [21:52:06.6017] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54364, waiting for next request...\ [21:52:11.6408] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:11.6421] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54365 (Slim::Web::HTTP::ClientConn=GLOB(0x572dda4)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:11.6427] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:52:11.6437] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:11.6441] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:11.6447] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:52:11.6451] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:52:11.6454] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:52:11.6457] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:52:11.6460] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:52:11.6463] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:11.6467] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:11.6470] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:11.6473] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:52:11.6477] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:11.6480] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:52:11.6483] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:52:11.6486] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:11.6491] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:11.6494] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:11.6497] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:52:11.6501] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:11.6505] Slim::Control::Request::execute (1754) Enter\ [21:52:11.6509] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:52:11.6513] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:11.6516] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:11.6519] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:11.6523] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:52:11.6548] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:52:11.6552] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:11.6555] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:11.6559] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:11.6562] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:52:11.6565] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:52:11.6569] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:52:11.6572] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:52:11.6576] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:52:11.6580] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:52:11.6583] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:52:11.6587] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:52:11.6591] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:52:11.6594] Slim::Control::Request::executeDone (1822) 0\ [21:52:11.6608] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54365\ [21:52:11.6613] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54365\ [21:52:11.6620] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54365, waiting for next request...\ [21:52:16.7013] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:16.7026] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54364 (Slim::Web::HTTP::ClientConn=GLOB(0x57b3478)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:16.7032] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:52:16.7040] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:16.7044] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:16.7050] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:52:16.7053] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:52:16.7057] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:52:16.7060] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:52:16.7063] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:52:16.7066] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:16.7069] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:16.7073] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:16.7076] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:52:16.7080] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:16.7083] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:52:16.7086] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:52:16.7089] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:16.7092] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:16.7096] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:16.7099] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:52:16.7102] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:16.7106] Slim::Control::Request::execute (1754) Enter\ [21:52:16.7110] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:52:16.7114] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:16.7117] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:16.7120] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:16.7124] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:52:16.7148] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:52:16.7152] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:16.7156] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:16.7159] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:16.7163] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:52:16.7166] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:52:16.7170] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:52:16.7173] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:52:16.7177] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:52:16.7180] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:52:16.7184] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:52:16.7188] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:52:16.7191] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:52:16.7194] Slim::Control::Request::executeDone (1822) 0\ [21:52:16.7208] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54364\ [21:52:16.7214] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54364\ [21:52:16.7221] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54364, waiting for next request...\ [21:52:21.4708] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:21.4722] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54365 (Slim::Web::HTTP::ClientConn=GLOB(0x572dda4)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:21.4728] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 69\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["",["serverstatus",0,999]]\}\ ]\ [21:52:21.4746] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:21.4750] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:21.4756] Slim::Control::Request::__parse (2367) Request: parse(serverstatus 0 999)\ [21:52:21.4760] Slim::Control::Request::__parse (2387) ..Trying to match [serverstatus]\ [21:52:21.4763] Slim::Control::Request::__parse (2472) ..[serverstatus] is HASH\ [21:52:21.4767] Slim::Control::Request::__parse (2387) ..Trying to match [0]\ [21:52:21.4770] Slim::Control::Request::__parse (2395) ..no match for [0]\ [21:52:21.4773] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:21.4776] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:21.4779] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:21.4783] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, 0]\ [21:52:21.4786] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:21.4790] Slim::Control::Request::__parse (2387) ..Trying to match [999]\ [21:52:21.4793] Slim::Control::Request::__parse (2395) ..no match for [999]\ [21:52:21.4796] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:21.4800] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:21.4803] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:21.4806] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 999]\ [21:52:21.6404] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:21.6410] Slim::Control::Request::execute (1754) Enter\ [21:52:21.6416] Slim::Control::Request::dump (2256) Request: Query [serverstatus] from JSONRPC (Dispatchable)\ [21:52:21.6420] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:52:21.6424] Slim::Control::Request::dump (2260) Param: [_quantity] = [999]\ [21:52:21.6429] Slim::Control::Queries::serverstatusQuery (2917) serverstatusQuery()\ [21:52:21.6590] Slim::Control::Request::dump (2256) Request: Query [serverstatus] from JSONRPC (Done)\ [21:52:21.6595] Slim::Control::Request::dump (2260) Param: [_index] = [0]\ [21:52:21.6598] Slim::Control::Request::dump (2260) Param: [_quantity] = [999]\ [21:52:21.6602] Slim::Control::Request::dump (2282) Result: [version] = [7.1]\ [21:52:21.6605] Slim::Control::Request::dump (2282) Result: [info total albums] = [156]\ [21:52:21.6609] Slim::Control::Request::dump (2282) Result: [info total artists] = [398]\ [21:52:21.6612] Slim::Control::Request::dump (2282) Result: [info total genres] = [32]\ [21:52:21.6616] Slim::Control::Request::dump (2282) Result: [info total songs] = [1769]\ [21:52:21.6619] Slim::Control::Request::dump (2282) Result: [player count] = [1]\ [21:52:21.6622] Slim::Control::Request::dump (2269) Result: [players_loop] is loop with 1 elements:\ [21:52:21.6626] Slim::Control::Request::dump (2277) Result: 0. [playerid] = [00:04:20:16:06:17]\ [21:52:21.6630] Slim::Control::Request::dump (2277) Result: 0. [uuid] = [de2d825317cb52f96676afe3f0694635]\ [21:52:21.6633] Slim::Control::Request::dump (2277) Result: 0. [ip] = [192.168.1.70:45918]\ [21:52:21.6637] Slim::Control::Request::dump (2277) Result: 0. [name] = [Ray]\ [21:52:21.6640] Slim::Control::Request::dump (2277) Result: 0. [model] = [receiver]\ [21:52:21.6643] Slim::Control::Request::dump (2277) Result: 0. [power] = [1]\ [21:52:21.6648] Slim::Control::Request::dump (2277) Result: 0. [displaytype] = [none]\ [21:52:21.6651] Slim::Control::Request::dump (2277) Result: 0. [canpoweroff] = [1]\ [21:52:21.6655] Slim::Control::Request::dump (2277) Result: 0. [connected] = [1]\ [21:52:21.6658] Slim::Control::Request::dump (2277) Result: 0. [isplayer] = [1]\ [21:52:21.6662] Slim::Control::Request::dump (2282) Result: [sn player count] = [0]\ [21:52:21.6665] Slim::Control::Request::dump (2282) Result: [other player count] = [4]\ [21:52:21.6668] Slim::Control::Request::dump (2269) Result: [other_players_loop] is loop with 4 elements:\ [21:52:21.6672] Slim::Control::Request::dump (2277) Result: 0. [playerid] = [00:04:20:06:17:4c]\ [21:52:21.6675] Slim::Control::Request::dump (2277) Result: 0. [name] = [Kitchen]\ [21:52:21.6679] Slim::Control::Request::dump (2277) Result: 0. [model] = [squeezebox2]\ [21:52:21.6682] Slim::Control::Request::dump (2277) Result: 0. [server] = [harrypotter]\ [21:52:21.6686] Slim::Control::Request::dump (2277) Result: 0. [serverurl] = [http://192.168.1.1:9000/]\ [21:52:21.6689] Slim::Control::Request::dump (2277) Result: 1. [playerid] = [00:04:20:1e:00:8c]\ [21:52:21.6692] Slim::Control::Request::dump (2277) Result: 1. [name] = [Bedroom]\ [21:52:21.6696] Slim::Control::Request::dump (2277) Result: 1. [model] = [boom]\ [21:52:21.6700] Slim::Control::Request::dump (2277) Result: 1. [server] = [harrypotter]\ [21:52:21.6703] Slim::Control::Request::dump (2277) Result: 1. [serverurl] = [http://192.168.1.1:9000/]\ [21:52:21.6707] Slim::Control::Request::dump (2277) Result: 2. [playerid] = [00:04:20:10:00:02]\ [21:52:21.6710] Slim::Control::Request::dump (2277) Result: 2. [name] = [Transporter]\ [21:52:21.6714] Slim::Control::Request::dump (2277) Result: 2. [model] = [transporter]\ [21:52:21.6717] Slim::Control::Request::dump (2277) Result: 2. [server] = [harrypotter]\ [21:52:21.6720] Slim::Control::Request::dump (2277) Result: 2. [serverurl] = [http://192.168.1.1:9000/]\ [21:52:21.9176] Slim::Control::Request::dump (2277) Result: 3. [playerid] = [00:04:20:1e:00:12]\ [21:52:21.9181] Slim::Control::Request::dump (2277) Result: 3. [name] = [Squeezebox 4]\ [21:52:21.9185] Slim::Control::Request::dump (2277) Result: 3. [model] = [boom]\ [21:52:21.9189] Slim::Control::Request::dump (2277) Result: 3. [server] = [harrypotter]\ [21:52:21.9194] Slim::Control::Request::dump (2277) Result: 3. [serverurl] = [http://192.168.1.1:9000/]\ [21:52:21.9198] Slim::Control::Request::executeDone (1822) 0\ [21:52:21.9222] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:21.9235] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54364 (Slim::Web::HTTP::ClientConn=GLOB(0x57b3478)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:21.9241] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:52:21.9250] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:21.9254] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:21.9260] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:52:21.9263] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:52:21.9266] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:52:21.9270] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:52:21.9273] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:52:21.9276] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:21.9279] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:21.9283] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:21.9286] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:52:21.9290] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:21.9293] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:52:21.9296] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:52:21.9299] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:21.9302] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:21.9305] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:21.9309] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:52:21.9312] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:21.9316] Slim::Control::Request::execute (1754) Enter\ [21:52:21.9320] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:52:21.9323] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:21.9326] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:21.9330] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:21.9333] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:52:21.9358] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:52:21.9363] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:21.9366] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:21.9369] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:21.9373] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:52:21.9377] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:52:21.9381] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:52:21.9384] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:52:21.9388] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:52:21.9391] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:52:21.9395] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:52:21.9398] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:52:21.9401] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:52:21.9405] Slim::Control::Request::executeDone (1822) 0\ [21:52:21.9417] Slim::Web::HTTP::sendResponse (1748) Sent 1214 to 127.0.0.1:54365\ [21:52:21.9422] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54365\ [21:52:21.9430] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54365, waiting for next request...\ [21:52:21.9436] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54364\ [21:52:21.9440] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54364\ [21:52:21.9448] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54364, waiting for next request...\ [21:52:26.9716] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:26.9730] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54365 (Slim::Web::HTTP::ClientConn=GLOB(0x572dda4)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:26.9735] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:52:26.9745] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:26.9748] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:26.9754] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:52:26.9758] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:52:26.9761] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:52:26.9764] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:52:26.9767] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:52:26.9770] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:26.9774] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:26.9777] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:26.9781] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:52:26.9784] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:26.9787] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:52:26.9790] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:52:26.9795] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:26.9798] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:26.9801] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:26.9804] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:52:26.9809] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:26.9813] Slim::Control::Request::execute (1754) Enter\ [21:52:26.9817] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:52:26.9820] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:26.9824] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:26.9828] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:26.9831] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:52:26.9855] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:52:26.9859] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:26.9862] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:26.9866] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:26.9869] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:52:26.9873] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:52:26.9876] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:52:26.9879] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:52:26.9883] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:52:26.9886] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:52:26.9889] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:52:26.9893] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:52:26.9896] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:52:26.9899] Slim::Control::Request::executeDone (1822) 0\ [21:52:26.9912] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54365\ [21:52:26.9918] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54365\ [21:52:26.9925] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54365, waiting for next request...\ [21:52:32.0326] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:32.0340] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54364 (Slim::Web::HTTP::ClientConn=GLOB(0x57b3478)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:32.0346] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:52:32.0355] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:32.0358] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:32.0364] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:52:32.0368] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:52:32.0372] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:52:32.0375] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:52:32.0378] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:52:32.0381] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:32.0385] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:32.0388] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:32.0391] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:52:32.0394] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:32.0398] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:52:32.0401] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:52:32.0404] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:32.0407] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:32.0410] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:32.0413] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:52:32.0417] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:32.0421] Slim::Control::Request::execute (1754) Enter\ [21:52:32.0425] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:52:32.0428] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:32.0431] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:32.0435] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:32.0438] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:52:32.0462] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:52:32.0466] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:32.0469] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:32.0473] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:32.0476] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:52:32.0480] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:52:32.0483] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:52:32.0486] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:52:32.0490] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:52:32.0493] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:52:32.0497] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:52:32.0500] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:52:32.0504] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:52:32.0508] Slim::Control::Request::executeDone (1822) 0\ [21:52:32.0521] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54364\ [21:52:32.0526] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54364\ [21:52:32.0533] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54364, waiting for next request...\ [21:52:37.0929] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:37.0942] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54365 (Slim::Web::HTTP::ClientConn=GLOB(0x572dda4)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:37.0948] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:52:37.0958] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:37.0961] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:37.0967] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:52:37.0971] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:52:37.0974] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:52:37.0977] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:52:37.0980] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:52:37.0984] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:37.0987] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:37.0990] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:37.0993] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:52:37.0997] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:37.1000] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:52:37.1003] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:52:37.1006] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:37.1009] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:37.1013] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:37.1016] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:52:37.1019] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:37.1023] Slim::Control::Request::execute (1754) Enter\ [21:52:37.1027] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:52:37.1030] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:37.1034] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:37.1037] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:37.1041] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:52:37.1065] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:52:37.1069] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:37.1072] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:37.1076] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:37.1079] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:52:37.1082] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:52:37.1086] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:52:37.1089] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:52:37.1093] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:52:37.1096] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:52:37.1100] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:52:37.1104] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:52:37.1107] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:52:37.1110] Slim::Control::Request::executeDone (1822) 0\ [21:52:37.1123] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54365\ [21:52:37.1128] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54365\ [21:52:37.1136] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54365, waiting for next request...\ [21:52:42.1537] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:42.1551] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54364 (Slim::Web::HTTP::ClientConn=GLOB(0x57b3478)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:42.1556] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:52:42.1566] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:42.1569] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:42.1576] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:52:42.1579] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:52:42.1582] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:52:42.1585] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:52:42.1589] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:52:42.1592] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:42.1595] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:42.1598] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:42.1601] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:52:42.1605] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:42.1608] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:52:42.1611] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:52:42.1615] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:42.1619] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:42.1622] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:42.1625] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:52:42.1629] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:42.1633] Slim::Control::Request::execute (1754) Enter\ [21:52:42.1637] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:52:42.1640] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:42.1643] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:42.1647] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:42.1650] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:52:42.1675] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:52:42.1679] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:42.1682] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:42.1686] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:42.1689] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:52:42.1693] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:52:42.1696] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:52:42.1699] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:52:42.1703] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:52:42.1707] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:52:42.1710] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:52:42.1714] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:52:42.1717] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:52:42.1720] Slim::Control::Request::executeDone (1822) 0\ [21:52:42.1734] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54364\ [21:52:42.1740] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54364\ [21:52:42.1747] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54364, waiting for next request...\ [21:52:47.2153] Slim::Web::HTTP::processHTTP (360) Reading request...\ [21:52:47.2167] Slim::Web::HTTP::processHTTP (377) HTTP request: from 127.0.0.1:54365 (Slim::Web::HTTP::ClientConn=GLOB(0x572dda4)) for POST HTTP/1.1 /jsonrpc.js\ [21:52:47.2173] Slim::Web::HTTP::processHTTP (384) Raw request headers: [\ POST /jsonrpc.js HTTP/1.1\ Cache-Control: no-cache\ Connection: keep-alive\ Pragma: no-cache\ Accept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\ Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\ Accept-Encoding: gzip,deflate\ Accept-Language: en-us,en;q=0.5\ Host: 127.0.0.1:9000\ Referer: http://127.0.0.1:9000/\ User-Agent: Mozilla/5.0 (Macintosh; U; Intel Mac OS X; en-US; rv:1.8.1.14) Gecko/20080404 Firefox/2.0.0.14\ Content-Length: 90\ Content-Type: application/x-www-form-urlencoded\ Cookie: SqueezeCenter-player=00%3A04%3A20%3A16%3A06%3A17; SqueezeCenter-expandPlayerControl=true; SqueezeCenter-expanded-MY_MUSIC=0; SqueezeCenter-expanded-RADIO=0; SqueezeCenter-expanded-MUSIC_SERVICES=0; SqueezeCenter-expanded-FAVORITES=0; SqueezeCenter-expanded-PLUGINS=0; SqueezeCenter-advancedsettings=settings/server/debugging.html?\ Keep-Alive: 300\ X-Requested-With: XMLHttpRequest\ \ \{"id":1,"method":"slim.request","params":["00:04:20:16:06:17",["status","-",1,"tags:uB"]]\}\ ]\ [21:52:47.2186] Slim::Web::HTTP::processHTTP (484) Raw path is [/jsonrpc.js]\ [21:52:47.2191] Slim::Web::HTTP::processHTTP (492) Handling [/jsonrpc.js] using raw function\ [21:52:47.2197] Slim::Control::Request::__parse (2367) Request: parse(status - 1 tags:uB)\ [21:52:47.2201] Slim::Control::Request::__parse (2387) ..Trying to match [status]\ [21:52:47.2204] Slim::Control::Request::__parse (2472) ..[status] is HASH\ [21:52:47.2207] Slim::Control::Request::__parse (2387) ..Trying to match [-]\ [21:52:47.2210] Slim::Control::Request::__parse (2395) ..no match for [-]\ [21:52:47.2213] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:47.2216] Slim::Control::Request::__parse (2417) ....considering [_index]\ [21:52:47.2220] Slim::Control::Request::__parse (2423) ....[_index] starts with _\ [21:52:47.2223] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_index, -]\ [21:52:47.2227] Slim::Control::Request::__parse (2472) ..[_index] is HASH\ [21:52:47.2230] Slim::Control::Request::__parse (2387) ..Trying to match [1]\ [21:52:47.2233] Slim::Control::Request::__parse (2395) ..no match for [1]\ [21:52:47.2236] Slim::Control::Request::__parse (2411) ...looking for a key starting with _\ [21:52:47.2239] Slim::Control::Request::__parse (2417) ....considering [_quantity]\ [21:52:47.2242] Slim::Control::Request::__parse (2423) ....[_quantity] starts with _\ [21:52:47.2246] Slim::Control::Request::__parse (2430) ....not out of verbs, adding param [_quantity, 1]\ [21:52:47.2249] Slim::Control::Request::__parse (2453) ..[_quantity] is ARRAY -> done\ [21:52:47.2253] Slim::Control::Request::execute (1754) Enter\ [21:52:47.2257] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Dispatchable)\ [21:52:47.2260] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:47.2264] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:47.2267] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:47.2271] Slim::Control::Queries::statusQuery (3202) statusQuery()\ [21:52:47.2296] Slim::Control::Request::dump (2256) Request: Query [00:04:20:16:06:17->status] from JSONRPC (Done)\ [21:52:47.2300] Slim::Control::Request::dump (2260) Param: [_index] = [-]\ [21:52:47.2303] Slim::Control::Request::dump (2260) Param: [_quantity] = [1]\ [21:52:47.2307] Slim::Control::Request::dump (2260) Param: [tags] = [uB]\ [21:52:47.2310] Slim::Control::Request::dump (2282) Result: [player_name] = [Ray]\ [21:52:47.2314] Slim::Control::Request::dump (2282) Result: [player_connected] = [1]\ [21:52:47.2317] Slim::Control::Request::dump (2282) Result: [player_ip] = [192.168.1.70:45918]\ [21:52:47.2321] Slim::Control::Request::dump (2282) Result: [power] = [1]\ [21:52:47.2324] Slim::Control::Request::dump (2282) Result: [mode] = [stop]\ [21:52:47.2327] Slim::Control::Request::dump (2282) Result: [mixer volume] = [76.25]\ [21:52:47.2331] Slim::Control::Request::dump (2282) Result: [playlist repeat] = [2]\ [21:52:47.2334] Slim::Control::Request::dump (2282) Result: [playlist shuffle] = [0]\ [21:52:47.2338] Slim::Control::Request::dump (2282) Result: [playlist_tracks] = [0]\ [21:52:47.2341] Slim::Control::Request::executeDone (1822) 0\ [21:52:47.2354] Slim::Web::HTTP::sendResponse (1748) Sent 453 to 127.0.0.1:54365\ [21:52:47.2360] Slim::Web::HTTP::sendResponse (1754) No more segments to send to 127.0.0.1:54365\ [21:52:47.2368] Slim::Web::HTTP::sendResponse (1706) No segment to send to 127.0.0.1:54365, waiting for next request...}