[09-08-13 09:59:30.1480] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35661, offset=1250149407.43868 [09-08-13 09:59:30.1624] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2687567, output_fullness=3515992, elapsed=245.817 [09-08-13 09:59:30.1737] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2687567 (85%) bufferSize 3145728 fullness 2687567 bytes_received 12923141 signal_strength: 33 jiffies: 962701 voltage: 0 [09-08-13 09:59:30.1850] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3515992 elapsed seconds: 245 [09-08-13 09:59:30.1942] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 245817 server timestamp: 0 [09-08-13 09:59:30.2083] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:30.2198] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35661, offset=1250149406.51047 [09-08-13 09:59:30.2321] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2647860, output_fullness=3522648, elapsed=246.817 [09-08-13 09:59:30.2422] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2647860 (84%) bufferSize 3145728 fullness 2647860 bytes_received 12923141 signal_strength: 38 jiffies: 963701 voltage: 0 [09-08-13 09:59:30.2537] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3522648 elapsed seconds: 246 [09-08-13 09:59:30.2635] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 246817 server timestamp: 0 [09-08-13 09:59:30.2747] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:30.2867] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105353.41488 [09-08-13 09:59:30.2996] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2777428, output_fullness=3514904, elapsed=243.567 [09-08-13 09:59:30.3136] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2777428 (88%) bufferSize 3145728 fullness 2777428 bytes_received 12923141 signal_strength: 68 jiffies: 45016863 voltage: 0 [09-08-13 09:59:30.3226] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3514904 elapsed seconds: 243 [09-08-13 09:59:30.3314] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 243567 server timestamp: 0 [09-08-13 09:59:30.3441] Slim::Player::StreamingController::_CheckSync (454) 00:04:20:07:a8:c6 bailing as playPoint too old: 4.53806114196777s [09-08-13 09:59:30.3598] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:30.3719] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105352.50056 [09-08-13 09:59:30.3843] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2737722, output_fullness=3521560, elapsed=244.567 [09-08-13 09:59:30.3953] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2737722 (87%) bufferSize 3145728 fullness 2737722 bytes_received 12923141 signal_strength: 70 jiffies: 45017863 voltage: 0 [09-08-13 09:59:30.4055] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3521560 elapsed seconds: 244 [09-08-13 09:59:30.4183] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 244567 server timestamp: 0 [09-08-13 09:59:30.4294] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:30.4414] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105351.56962 [09-08-13 09:59:30.4535] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2698016, output_fullness=3518744, elapsed=245.568 [09-08-13 09:59:30.4670] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2698016 (85%) bufferSize 3145728 fullness 2698016 bytes_received 12923141 signal_strength: 68 jiffies: 45018863 voltage: 0 [09-08-13 09:59:30.4775] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3518744 elapsed seconds: 245 [09-08-13 09:59:30.4876] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 245568 server timestamp: 0 [09-08-13 09:59:30.6295] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:30.6413] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105350.76991 [09-08-13 09:59:30.6537] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2656220, output_fullness=3516312, elapsed=246.567 [09-08-13 09:59:30.6679] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2656220 (84%) bufferSize 3145728 fullness 2656220 bytes_received 12923141 signal_strength: 68 jiffies: 45019863 voltage: 0 [09-08-13 09:59:30.6771] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3516312 elapsed seconds: 246 [09-08-13 09:59:30.6868] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 246567 server timestamp: 0 [09-08-13 09:59:30.6971] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:30.7090] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105349.83731 [09-08-13 09:59:30.7296] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2616514, output_fullness=3515992, elapsed=247.567 [09-08-13 09:59:30.7413] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2616514 (83%) bufferSize 3145728 fullness 2616514 bytes_received 12923141 signal_strength: 70 jiffies: 45020863 voltage: 0 [09-08-13 09:59:30.7503] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3515992 elapsed seconds: 247 [09-08-13 09:59:30.7593] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 247567 server timestamp: 0 [09-08-13 09:59:30.8004] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:30.8112] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35661, offset=1250149406.10177 [09-08-13 09:59:30.8219] Slim::Player::Player::trackJiffiesEpoch (951) 00:04:20:07:4e:dc adjust jiffies epoch +0.001s [09-08-13 09:59:30.8359] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2608154, output_fullness=3519960, elapsed=247.818 [09-08-13 09:59:30.8477] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2608154 (82%) bufferSize 3145728 fullness 2608154 bytes_received 12923141 signal_strength: 36 jiffies: 964701 voltage: 0 [09-08-13 09:59:30.8567] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3519960 elapsed seconds: 247 [09-08-13 09:59:30.8703] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 247818 server timestamp: 0 [09-08-13 09:59:30.8849] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:30.8960] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105349.02422 [09-08-13 09:59:30.9081] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2576807, output_fullness=3520344, elapsed=248.567 [09-08-13 09:59:30.9199] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2576807 (81%) bufferSize 3145728 fullness 2576807 bytes_received 12923141 signal_strength: 68 jiffies: 45021863 voltage: 0 [09-08-13 09:59:30.9319] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3520344 elapsed seconds: 248 [09-08-13 09:59:30.9423] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 248567 server timestamp: 0 [09-08-13 09:59:30.9793] Slim::Networking::Slimproto::check_all_clients (212) Checking if 00:04:20:07:4e:dc is still alive [09-08-13 09:59:30.9894] Slim::Player::Squeezebox::stream (931) strm-t [09-08-13 09:59:30.9985] Slim::Player::Squeezebox::stream (976) sending strm frame of length: 24 [09-08-13 09:59:31.0081] Slim::Player::Squeezebox::sendFrame (1055) sending squeezebox frame: strm, length: 24 [09-08-13 09:59:31.0350] Slim::Networking::Slimproto::check_all_clients (212) Checking if 00:04:20:07:a8:c6 is still alive [09-08-13 09:59:31.0453] Slim::Player::Squeezebox::stream (931) strm-t [09-08-13 09:59:31.0546] Slim::Player::Squeezebox::stream (976) sending strm frame of length: 24 [09-08-13 09:59:31.0656] Slim::Player::Squeezebox::sendFrame (1055) sending squeezebox frame: strm, length: 24 [09-08-13 09:59:31.0924] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:31.1047] Slim::Networking::Slimproto::_stat_handler (734) 00:04:20:07:4e:dc latency=22, from (42.5, 69, 23, 22, 24, 78, 73, 132, 73.5, 51.5) [09-08-13 09:59:31.1142] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35808, offset=1250149405.42577 [09-08-13 09:59:31.1265] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2568448, output_fullness=3519576, elapsed=248.785 [09-08-13 09:59:31.1380] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2568448 (81%) bufferSize 3145728 fullness 2568448 bytes_received 12923141 signal_strength: 36 jiffies: 965669 voltage: 0 [09-08-13 09:59:31.1487] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3519576 elapsed seconds: 248 [09-08-13 09:59:31.1576] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 248785 server timestamp: 314888147 [09-08-13 09:59:31.1684] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:31.1812] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35808, offset=1250149405.50263 [09-08-13 09:59:31.1968] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-strm: fullness=2568448, output_fullness=3519320, elapsed=248.786 [09-08-13 09:59:31.2075] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: strm bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2568448 (81%) bufferSize 3145728 fullness 2568448 bytes_received 12923141 signal_strength: 36 jiffies: 965669 voltage: 0 [09-08-13 09:59:31.2166] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3519320 elapsed seconds: 248 [09-08-13 09:59:31.2257] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 248786 server timestamp: 0 [09-08-13 09:59:31.2372] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:31.2504] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35808, offset=1250149405.53936 [09-08-13 09:59:31.2628] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2566358, output_fullness=3517528, elapsed=248.817 [09-08-13 09:59:31.2736] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2566358 (81%) bufferSize 3145728 fullness 2566358 bytes_received 12923141 signal_strength: 38 jiffies: 965701 voltage: 0 [09-08-13 09:59:31.2826] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3517528 elapsed seconds: 248 [09-08-13 09:59:31.2980] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 248817 server timestamp: 0 [09-08-13 09:59:31.3093] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:31.3218] Slim::Networking::Slimproto::_stat_handler (734) 00:04:20:07:a8:c6 latency=76.5, from (76.5, 122, 123.5, 120, 181.5, 196.5, 142.5, 183.5, 129.5, 131.5) [09-08-13 09:59:31.3310] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105349.16562 [09-08-13 09:59:31.3467] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2566358, output_fullness=3521624, elapsed=248.851 [09-08-13 09:59:31.3566] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2566358 (81%) bufferSize 3145728 fullness 2566358 bytes_received 12923141 signal_strength: 68 jiffies: 45022146 voltage: 0 [09-08-13 09:59:31.3655] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3521624 elapsed seconds: 248 [09-08-13 09:59:31.3755] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 248851 server timestamp: 314888204 [09-08-13 09:59:31.3912] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.230, 00:04:20:07:4e:dc: +12 [09-08-13 09:59:31.4054] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:31.4161] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105349.26071 [09-08-13 09:59:31.4284] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-strm: fullness=2566358, output_fullness=3521368, elapsed=248.852 [09-08-13 09:59:31.4401] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: strm bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2566358 (81%) bufferSize 3145728 fullness 2566358 bytes_received 12923141 signal_strength: 68 jiffies: 45022147 voltage: 0 [09-08-13 09:59:31.4518] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3521368 elapsed seconds: 248 [09-08-13 09:59:31.4610] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 248852 server timestamp: 0 [09-08-13 09:59:31.8447] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:31.8611] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105348.98665 [09-08-13 09:59:31.8768] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2537101, output_fullness=3517656, elapsed=249.567 [09-08-13 09:59:31.8868] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2537101 (80%) bufferSize 3145728 fullness 2537101 bytes_received 12923141 signal_strength: 70 jiffies: 45022863 voltage: 0 [09-08-13 09:59:31.8969] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3517656 elapsed seconds: 249 [09-08-13 09:59:31.9082] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 249567 server timestamp: 0 [09-08-13 09:59:32.0583] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:32.0700] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35808, offset=1250149405.36047 [09-08-13 09:59:32.0820] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2526652, output_fullness=3514968, elapsed=249.817 [09-08-13 09:59:32.0919] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2526652 (80%) bufferSize 3145728 fullness 2526652 bytes_received 12923141 signal_strength: 30 jiffies: 966701 voltage: 0 [09-08-13 09:59:32.1010] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3514968 elapsed seconds: 249 [09-08-13 09:59:32.1160] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 249817 server timestamp: 0 [09-08-13 09:59:32.7947] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:32.8064] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105348.93487 [09-08-13 09:59:32.8186] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2497395, output_fullness=3515096, elapsed=250.567 [09-08-13 09:59:32.8328] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2497395 (79%) bufferSize 3145728 fullness 2497395 bytes_received 12923141 signal_strength: 68 jiffies: 45023863 voltage: 0 [09-08-13 09:59:32.8418] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3515096 elapsed seconds: 250 [09-08-13 09:59:32.8515] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 250567 server timestamp: 0 [09-08-13 09:59:32.8665] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.231, 00:04:20:07:4e:dc: +11 [09-08-13 09:59:33.0546] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:33.0661] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35808, offset=1250149405.35675 [09-08-13 09:59:33.0796] Slim::Player::Player::trackJiffiesEpoch (927) 00:04:20:07:4e:dc adjust jiffies epoch -0.001s [09-08-13 09:59:33.0916] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2486946, output_fullness=3521496, elapsed=250.817 [09-08-13 09:59:33.1023] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2486946 (79%) bufferSize 3145728 fullness 2486946 bytes_received 12923141 signal_strength: 33 jiffies: 967701 voltage: 0 [09-08-13 09:59:33.1116] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3521496 elapsed seconds: 250 [09-08-13 09:59:33.1205] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 250817 server timestamp: 0 [09-08-13 09:59:33.8208] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:33.8400] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105348.96153 [09-08-13 09:59:33.8542] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2457689, output_fullness=3521752, elapsed=251.567 [09-08-13 09:59:33.8647] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2457689 (78%) bufferSize 3145728 fullness 2457689 bytes_received 12923141 signal_strength: 71 jiffies: 45024863 voltage: 0 [09-08-13 09:59:33.8754] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3521752 elapsed seconds: 251 [09-08-13 09:59:33.8846] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 251567 server timestamp: 0 [09-08-13 09:59:33.9019] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.231, 00:04:20:07:4e:dc: +10 [09-08-13 09:59:34.0621] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:34.0739] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35675, offset=1250149405.36427 [09-08-13 09:59:34.0874] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2447240, output_fullness=3518936, elapsed=251.817 [09-08-13 09:59:34.1011] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2447240 (77%) bufferSize 3145728 fullness 2447240 bytes_received 12923141 signal_strength: 30 jiffies: 968701 voltage: 0 [09-08-13 09:59:34.1103] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3518936 elapsed seconds: 251 [09-08-13 09:59:34.1193] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 251817 server timestamp: 0 [09-08-13 09:59:34.7959] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:34.8121] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105348.94054 [09-08-13 09:59:34.8774] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2417983, output_fullness=3519064, elapsed=252.567 [09-08-13 09:59:34.8886] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2417983 (76%) bufferSize 3145728 fullness 2417983 bytes_received 12923141 signal_strength: 73 jiffies: 45025863 voltage: 0 [09-08-13 09:59:34.8994] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3519064 elapsed seconds: 252 [09-08-13 09:59:34.9107] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 252567 server timestamp: 0 [09-08-13 09:59:34.9260] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.231, 00:04:20:07:4e:dc: +10 [09-08-13 09:59:35.0103] Slim::Networking::Slimproto::check_all_clients (212) Checking if 00:04:20:07:4e:dc is still alive [09-08-13 09:59:35.0206] Slim::Player::Squeezebox::stream (931) strm-t [09-08-13 09:59:35.0298] Slim::Player::Squeezebox::stream (976) sending strm frame of length: 24 [09-08-13 09:59:35.0397] Slim::Player::Squeezebox::sendFrame (1055) sending squeezebox frame: strm, length: 24 [09-08-13 09:59:35.0508] Slim::Networking::Slimproto::check_all_clients (212) Checking if 00:04:20:07:a8:c6 is still alive [09-08-13 09:59:35.0581] Slim::Player::Squeezebox::stream (931) strm-t [09-08-13 09:59:35.0640] Slim::Player::Squeezebox::stream (976) sending strm frame of length: 24 [09-08-13 09:59:35.0696] Slim::Player::Squeezebox::sendFrame (1055) sending squeezebox frame: strm, length: 24 [09-08-13 09:59:35.0788] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:35.0863] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35675, offset=1250149405.3798 [09-08-13 09:59:35.0946] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2407534, output_fullness=3516376, elapsed=252.817 [09-08-13 09:59:35.1010] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2407534 (76%) bufferSize 3145728 fullness 2407534 bytes_received 12923141 signal_strength: 36 jiffies: 969701 voltage: 0 [09-08-13 09:59:35.1071] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3516376 elapsed seconds: 252 [09-08-13 09:59:35.1129] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 252817 server timestamp: 0 [09-08-13 09:59:35.1192] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:35.1269] Slim::Networking::Slimproto::_stat_handler (734) 00:04:20:07:4e:dc latency=22, from (69, 23, 22, 24, 78, 73, 132, 73.5, 51.5, 48.5) [09-08-13 09:59:35.1327] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35675, offset=1250149405.41899 [09-08-13 09:59:35.1400] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2407534, output_fullness=3515864, elapsed=252.819 [09-08-13 09:59:35.1463] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2407534 (76%) bufferSize 3145728 fullness 2407534 bytes_received 12923141 signal_strength: 36 jiffies: 969702 voltage: 0 [09-08-13 09:59:35.1520] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3515864 elapsed seconds: 252 [09-08-13 09:59:35.1576] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 252819 server timestamp: 314892179 [09-08-13 09:59:35.1638] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:35.1708] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35675, offset=1250149405.46263 [09-08-13 09:59:35.1782] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-strm: fullness=2407534, output_fullness=3515736, elapsed=252.819 [09-08-13 09:59:35.1847] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: strm bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2407534 (76%) bufferSize 3145728 fullness 2407534 bytes_received 12923141 signal_strength: 36 jiffies: 969703 voltage: 0 [09-08-13 09:59:35.1904] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3515736 elapsed seconds: 252 [09-08-13 09:59:35.1962] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 252819 server timestamp: 0 [09-08-13 09:59:35.2036] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:35.2111] Slim::Networking::Slimproto::_stat_handler (734) 00:04:20:07:a8:c6 latency=72.5, from (122, 123.5, 120, 181.5, 196.5, 142.5, 183.5, 129.5, 131.5, 72.5) [09-08-13 09:59:35.2173] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105349.05537 [09-08-13 09:59:35.2269] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2405444, output_fullness=3519064, elapsed=252.855 [09-08-13 09:59:35.2332] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2405444 (76%) bufferSize 3145728 fullness 2405444 bytes_received 12923141 signal_strength: 71 jiffies: 45026150 voltage: 0 [09-08-13 09:59:35.2390] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3519064 elapsed seconds: 252 [09-08-13 09:59:35.2448] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 252855 server timestamp: 314892215 [09-08-13 09:59:35.2516] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:35.2586] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105349.10237 [09-08-13 09:59:35.2661] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-strm: fullness=2405444, output_fullness=3518936, elapsed=252.855 [09-08-13 09:59:35.2724] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: strm bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2405444 (76%) bufferSize 3145728 fullness 2405444 bytes_received 12923141 signal_strength: 71 jiffies: 45026151 voltage: 0 [09-08-13 09:59:35.2780] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3518936 elapsed seconds: 252 [09-08-13 09:59:35.2838] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 252855 server timestamp: 0 [09-08-13 09:59:35.7917] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:35.7989] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93468, offset=1250105348.93071 [09-08-13 09:59:35.8044] Slim::Player::Player::trackJiffiesEpoch (927) 00:04:20:07:a8:c6 adjust jiffies epoch -0.004s [09-08-13 09:59:35.8118] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2376187, output_fullness=3516504, elapsed=253.567 [09-08-13 09:59:35.8181] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2376187 (75%) bufferSize 3145728 fullness 2376187 bytes_received 12923141 signal_strength: 71 jiffies: 45026863 voltage: 0 [09-08-13 09:59:35.8245] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3516504 elapsed seconds: 253 [09-08-13 09:59:35.8301] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 253567 server timestamp: 0 [09-08-13 09:59:36.0512] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:36.0583] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35675, offset=1250149405.3521 [09-08-13 09:59:36.0638] Slim::Player::Player::trackJiffiesEpoch (927) 00:04:20:07:4e:dc adjust jiffies epoch -0.005s [09-08-13 09:59:36.0711] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2367828, output_fullness=3523032, elapsed=253.817 [09-08-13 09:59:36.0775] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2367828 (75%) bufferSize 3145728 fullness 2367828 bytes_received 12923141 signal_strength: 36 jiffies: 970701 voltage: 0 [09-08-13 09:59:36.0834] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3523032 elapsed seconds: 253 [09-08-13 09:59:36.0890] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 253817 server timestamp: 0 [09-08-13 09:59:36.7916] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:36.7987] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93071, offset=1250105348.93046 [09-08-13 09:59:36.8062] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2336481, output_fullness=3513816, elapsed=254.568 [09-08-13 09:59:36.8126] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2336481 (74%) bufferSize 3145728 fullness 2336481 bytes_received 12923141 signal_strength: 71 jiffies: 45027863 voltage: 0 [09-08-13 09:59:36.8182] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3513816 elapsed seconds: 254 [09-08-13 09:59:36.8238] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 254568 server timestamp: 0 [09-08-13 09:59:36.8325] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.225, 00:04:20:07:4e:dc: +10 [09-08-13 09:59:37.0515] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:37.0585] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.3521, offset=1250149405.35235 [09-08-13 09:59:37.0659] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2328122, output_fullness=3520344, elapsed=254.817 [09-08-13 09:59:37.0722] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2328122 (74%) bufferSize 3145728 fullness 2328122 bytes_received 12923141 signal_strength: 36 jiffies: 971701 voltage: 0 [09-08-13 09:59:37.0780] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3520344 elapsed seconds: 254 [09-08-13 09:59:37.0836] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 254817 server timestamp: 0 [09-08-13 09:59:37.7916] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:37.7986] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93046, offset=1250105348.93043 [09-08-13 09:59:37.8062] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2296775, output_fullness=3520472, elapsed=255.568 [09-08-13 09:59:37.8125] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2296775 (73%) bufferSize 3145728 fullness 2296775 bytes_received 12923141 signal_strength: 73 jiffies: 45028863 voltage: 0 [09-08-13 09:59:37.8182] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3520472 elapsed seconds: 255 [09-08-13 09:59:37.8242] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 255568 server timestamp: 0 [09-08-13 09:59:37.8328] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.225, 00:04:20:07:4e:dc: +10 [09-08-13 09:59:38.0515] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:38.0585] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.3521, offset=1250149405.35231 [09-08-13 09:59:38.0658] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2286326, output_fullness=3517848, elapsed=255.817 [09-08-13 09:59:38.0722] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2286326 (72%) bufferSize 3145728 fullness 2286326 bytes_received 12923141 signal_strength: 36 jiffies: 972701 voltage: 0 [09-08-13 09:59:38.0778] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3517848 elapsed seconds: 255 [09-08-13 09:59:38.0838] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 255817 server timestamp: 0 [09-08-13 09:59:38.7916] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:38.7996] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93043, offset=1250105348.93138 [09-08-13 09:59:38.8069] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2257069, output_fullness=3517912, elapsed=256.567 [09-08-13 09:59:38.8132] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2257069 (71%) bufferSize 3145728 fullness 2257069 bytes_received 12923141 signal_strength: 71 jiffies: 45029863 voltage: 0 [09-08-13 09:59:38.8189] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3517912 elapsed seconds: 256 [09-08-13 09:59:38.8246] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 256567 server timestamp: 0 [09-08-13 09:59:38.8333] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.226, 00:04:20:07:4e:dc: +9 [09-08-13 09:59:39.0512] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:39.0582] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.3521, offset=1250149405.35202 [09-08-13 09:59:39.0658] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2246620, output_fullness=3515288, elapsed=256.817 [09-08-13 09:59:39.0721] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2246620 (71%) bufferSize 3145728 fullness 2246620 bytes_received 12923141 signal_strength: 38 jiffies: 973701 voltage: 0 [09-08-13 09:59:39.0778] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3515288 elapsed seconds: 256 [09-08-13 09:59:39.0836] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 256817 server timestamp: 0 [09-08-13 09:59:39.7915] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:39.7986] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93043, offset=1250105348.93038 [09-08-13 09:59:39.8060] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2217363, output_fullness=3515288, elapsed=257.568 [09-08-13 09:59:39.8123] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2217363 (70%) bufferSize 3145728 fullness 2217363 bytes_received 12923141 signal_strength: 73 jiffies: 45030863 voltage: 0 [09-08-13 09:59:39.8192] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3515288 elapsed seconds: 257 [09-08-13 09:59:39.8556] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 257568 server timestamp: 0 [09-08-13 09:59:39.8642] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.225, 00:04:20:07:4e:dc: +10 [09-08-13 09:59:40.0126] Slim::Networking::Discovery::gotTLVRequest (156) discovery packet:"eIPAD\0NAME\0JSON\0" [09-08-13 09:59:40.0180] Slim::Networking::Discovery::gotTLVRequest (173) TLV: IPAD len: 0 [09-08-13 09:59:40.0236] Slim::Networking::Discovery::gotTLVRequest (173) TLV: NAME len: 0 [09-08-13 09:59:40.0291] Slim::Networking::Discovery::gotTLVRequest (173) TLV: JSON len: 0 [09-08-13 09:59:40.0350] Slim::Networking::Discovery::gotTLVRequest (194) sending response [09-08-13 09:59:40.0407] Slim::Networking::Discovery::Server::gotTLVResponse (161) discovery response packet: [09-08-13 09:59:40.0471] Slim::Networking::Discovery::Server::gotTLVResponse (177) TLV: NAME len: 8, Turbonas [09-08-13 09:59:40.0534] Slim::Networking::Discovery::Server::gotTLVResponse (177) TLV: JSON len: 4, 9001 [09-08-13 09:59:40.0591] Slim::Networking::Discovery::Server::gotTLVResponse (197) Discovered server Turbonas (192.168.0.102), using port 9001 [09-08-13 09:59:40.0660] Slim::Networking::Slimproto::check_all_clients (212) Checking if 00:04:20:07:4e:dc is still alive [09-08-13 09:59:40.0718] Slim::Player::Squeezebox::stream (931) strm-t [09-08-13 09:59:40.0788] Slim::Player::Squeezebox::stream (976) sending strm frame of length: 24 [09-08-13 09:59:40.0848] Slim::Player::Squeezebox::sendFrame (1055) sending squeezebox frame: strm, length: 24 [09-08-13 09:59:40.0913] Slim::Networking::Slimproto::check_all_clients (212) Checking if 00:04:20:07:a8:c6 is still alive [09-08-13 09:59:40.0972] Slim::Player::Squeezebox::stream (931) strm-t [09-08-13 09:59:40.1040] Slim::Player::Squeezebox::stream (976) sending strm frame of length: 24 [09-08-13 09:59:40.1096] Slim::Player::Squeezebox::sendFrame (1055) sending squeezebox frame: strm, length: 24 [09-08-13 09:59:40.1190] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:40.1270] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35202, offset=1250149405.41983 [09-08-13 09:59:40.1345] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2206914, output_fullness=3521816, elapsed=257.817 [09-08-13 09:59:40.1408] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2206914 (70%) bufferSize 3145728 fullness 2206914 bytes_received 12923141 signal_strength: 41 jiffies: 974701 voltage: 0 [09-08-13 09:59:40.1468] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3521816 elapsed seconds: 257 [09-08-13 09:59:40.1524] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 257817 server timestamp: 0 [09-08-13 09:59:40.1597] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:40.1672] Slim::Networking::Slimproto::_stat_handler (734) 00:04:20:07:4e:dc latency=22, from (23, 22, 24, 78, 73, 132, 73.5, 51.5, 48.5, 43) [09-08-13 09:59:40.1729] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35202, offset=1250149405.4155 [09-08-13 09:59:40.1804] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2204824, output_fullness=3515160, elapsed=257.862 [09-08-13 09:59:40.1870] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2204824 (70%) bufferSize 3145728 fullness 2204824 bytes_received 12923141 signal_strength: 36 jiffies: 974746 voltage: 0 [09-08-13 09:59:40.1927] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3515160 elapsed seconds: 257 [09-08-13 09:59:40.1983] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 257862 server timestamp: 314897230 [09-08-13 09:59:40.2047] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:40.2117] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35202, offset=1250149405.45951 [09-08-13 09:59:40.2192] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-strm: fullness=2204824, output_fullness=3514904, elapsed=257.863 [09-08-13 09:59:40.2257] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: strm bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2204824 (70%) bufferSize 3145728 fullness 2204824 bytes_received 12923141 signal_strength: 36 jiffies: 974747 voltage: 0 [09-08-13 09:59:40.2313] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3514904 elapsed seconds: 257 [09-08-13 09:59:40.2369] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 257863 server timestamp: 0 [09-08-13 09:59:40.2451] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:40.2526] Slim::Networking::Slimproto::_stat_handler (734) 00:04:20:07:a8:c6 latency=72.5, from (123.5, 120, 181.5, 196.5, 142.5, 183.5, 129.5, 131.5, 72.5, 74) [09-08-13 09:59:40.2586] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93038, offset=1250105349.05689 [09-08-13 09:59:40.2670] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2204824, output_fullness=3519512, elapsed=257.895 [09-08-13 09:59:40.2733] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2204824 (70%) bufferSize 3145728 fullness 2204824 bytes_received 12923141 signal_strength: 68 jiffies: 45031190 voltage: 0 [09-08-13 09:59:40.2790] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3519512 elapsed seconds: 257 [09-08-13 09:59:40.2846] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 257895 server timestamp: 314897254 [09-08-13 09:59:40.2912] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:40.2984] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93038, offset=1250105349.10225 [09-08-13 09:59:40.3059] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-strm: fullness=2204824, output_fullness=3519384, elapsed=257.896 [09-08-13 09:59:40.3122] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: strm bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2204824 (70%) bufferSize 3145728 fullness 2204824 bytes_received 12923141 signal_strength: 68 jiffies: 45031191 voltage: 0 [09-08-13 09:59:40.3181] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3519384 elapsed seconds: 257 [09-08-13 09:59:40.3238] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 257896 server timestamp: 0 [09-08-13 09:59:40.7915] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:40.7989] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93038, offset=1250105348.93033 [09-08-13 09:59:40.8077] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2177656, output_fullness=3521944, elapsed=258.567 [09-08-13 09:59:40.8144] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2177656 (69%) bufferSize 3145728 fullness 2177656 bytes_received 12923141 signal_strength: 73 jiffies: 45031863 voltage: 0 [09-08-13 09:59:40.8200] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3521944 elapsed seconds: 258 [09-08-13 09:59:40.8265] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 258567 server timestamp: 0 [09-08-13 09:59:40.8353] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.226, 00:04:20:07:4e:dc: +9 [09-08-13 09:59:41.0511] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:41.0583] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35202, offset=1250149405.35214 [09-08-13 09:59:41.0657] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2167207, output_fullness=3519256, elapsed=258.817 [09-08-13 09:59:41.0720] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2167207 (68%) bufferSize 3145728 fullness 2167207 bytes_received 12923141 signal_strength: 41 jiffies: 975701 voltage: 0 [09-08-13 09:59:41.0779] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3519256 elapsed seconds: 258 [09-08-13 09:59:41.0834] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 258817 server timestamp: 0 [09-08-13 09:59:41.7916] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:41.7990] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93033, offset=1250105348.93084 [09-08-13 09:59:41.8073] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2137950, output_fullness=3519256, elapsed=259.568 [09-08-13 09:59:41.8139] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2137950 (67%) bufferSize 3145728 fullness 2137950 bytes_received 12923141 signal_strength: 71 jiffies: 45032863 voltage: 0 [09-08-13 09:59:41.8196] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3519256 elapsed seconds: 259 [09-08-13 09:59:41.8263] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 259568 server timestamp: 0 [09-08-13 09:59:41.8351] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.225, 00:04:20:07:4e:dc: +10 [09-08-13 09:59:42.0511] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:42.0584] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:4e:dc trackJiffiesEpoch: epoch=1250149405.35202, offset=1250149405.35199 [09-08-13 09:59:42.0660] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:4e:dc: STAT-STMt: fullness=2127501, output_fullness=3516696, elapsed=259.817 [09-08-13 09:59:42.0723] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:4e:dc Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2127501 (67%) bufferSize 3145728 fullness 2127501 bytes_received 12923141 signal_strength: 38 jiffies: 976701 voltage: 0 [09-08-13 09:59:42.0782] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3516696 elapsed seconds: 259 [09-08-13 09:59:42.0838] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 259817 server timestamp: 0 [09-08-13 09:59:42.7916] Slim::Networking::Slimproto::client_readable (391) Slimproto frame: STAT, len: 57 [09-08-13 09:59:42.7986] Slim::Player::Player::trackJiffiesEpoch (920) 00:04:20:07:a8:c6 trackJiffiesEpoch: epoch=1250105348.93033, offset=1250105348.93043 [09-08-13 09:59:42.8061] Slim::Networking::Slimproto::_stat_handler (786) 00:04:20:07:a8:c6: STAT-STMt: fullness=2096154, output_fullness=3516696, elapsed=260.568 [09-08-13 09:59:42.8124] Slim::Networking::Slimproto::_stat_handler (813) 00:04:20:07:a8:c6 Squeezebox stream status: event_code: STMt bytes_rec_H 0 bytes_rec_L 12923141 fullness: 2096154 (66%) bufferSize 3145728 fullness 2096154 bytes_received 12923141 signal_strength: 73 jiffies: 45033863 voltage: 0 [09-08-13 09:59:42.8182] Slim::Networking::Slimproto::_stat_handler (825) output size: 3528000 output fullness: 3516696 elapsed seconds: 260 [09-08-13 09:59:42.8238] Slim::Networking::Slimproto::_stat_handler (837) elapsed milliseconds: 260568 server timestamp: 0 [09-08-13 09:59:42.8324] Slim::Player::StreamingController::_CheckSync (470) playPoints: 00:04:20:07:a8:c6: 1250150122.225, 00:04:20:07:4e:dc: +10