[2019-12-31 16:27:23.558][DEBUG] : result 
[2019-12-31 16:27:23.558][DEBUG] : Setting volume for Player: b8:27:eb:a8:42:0d
[2019-12-31 16:27:23.558][DEBUG] : sent b8:27:eb:a8:42:0d mixer volume 40
[2019-12-31 16:27:24.794][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d playlist play http%3A%2F%2F192.168.1.10%3A80%2Fplugins%2Fsqueezeboxcontrol%2Fdata%2Fcache%2F460e01194c41056ace1ea4a4f3f29350.mp3  '
[2019-12-31 16:27:24.795][DEBUG] : result http://192.168.1.10:80/plugins/squeezeboxcontrol/data/cache/460e01194c41056ace1ea4a4f3f29350.mp3  
[2019-12-31 16:27:24.795][DEBUG] : TTS duration is 5.534648526077097
[2019-12-31 16:27:25.796][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:25.797][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mixer volume 40'
[2019-12-31 16:27:25.797][DEBUG] : result  volume 40
[2019-12-31 16:27:25.797][DEBUG] : Waiting end of TTS mode is volume 40
[2019-12-31 16:27:25][DEBUG] : Received : {"repeat":"0","shuffle":"0","titre":"TTS par Jeedom","artist":"","album":"TTS","statut":"Lecture","etat":"On","sync":"null"} de : b8:27:eb:a8:42:0d
[2019-12-31 16:27:25][DEBUG] : Image à récupérer : http://192.168.1.24:9002/music/current/cover_200x200.jpg?player=b8%3A27%3Aeb%3Aa8%3A42%3A0d&time=0.89772200 1577806045
[2019-12-31 16:27:26.298][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:26.298][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode play'
[2019-12-31 16:27:26.298][DEBUG] : result play
[2019-12-31 16:27:26.298][DEBUG] : Waiting end of TTS mode is play
[2019-12-31 16:27:26.799][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:28][DEBUG] : Received : {"volume":"40"} de : b8:27:eb:a8:42:0d
[2019-12-31 16:27:28.421][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode play'
[2019-12-31 16:27:28.421][DEBUG] : result play
[2019-12-31 16:27:28.421][DEBUG] : Waiting end of TTS mode is play
[2019-12-31 16:27:28.922][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:28.922][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode play'
[2019-12-31 16:27:28.922][DEBUG] : result play
[2019-12-31 16:27:28.922][DEBUG] : Waiting end of TTS mode is play
[2019-12-31 16:27:29][DEBUG] : Received : {"repeat":"0","shuffle":"0","titre":"TTS par Jeedom","artist":"","album":"TTS","statut":"Lecture","etat":"On","sync":"null"} de : b8:27:eb:a8:42:0d
[2019-12-31 16:27:29][DEBUG] : Image à récupérer : http://192.168.1.24:9002/music/current/cover_200x200.jpg?player=b8%3A27%3Aeb%3Aa8%3A42%3A0d&time=0.08690800 1577806049
[2019-12-31 16:27:29.423][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:29.423][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode play'
[2019-12-31 16:27:29.423][DEBUG] : result play
[2019-12-31 16:27:29.423][DEBUG] : Waiting end of TTS mode is play
[2019-12-31 16:27:29.924][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:29.924][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode play'
[2019-12-31 16:27:29.925][DEBUG] : result play
[2019-12-31 16:27:29.925][DEBUG] : Waiting end of TTS mode is play
[2019-12-31 16:27:30.425][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:30.426][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode play'
[2019-12-31 16:27:30.426][DEBUG] : result play
[2019-12-31 16:27:30.426][DEBUG] : Waiting end of TTS mode is play
[2019-12-31 16:27:30.926][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:30.927][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode play'
[2019-12-31 16:27:30.927][DEBUG] : result play
[2019-12-31 16:27:30.927][DEBUG] : Waiting end of TTS mode is play
[2019-12-31 16:27:31][DEBUG] : Received : {"repeat":"0","shuffle":"0","titre":"TTS par Jeedom","artist":"","album":"TTS","statut":"Stop","etat":"On","sync":"null"} de : b8:27:eb:a8:42:0d
[2019-12-31 16:27:31][DEBUG] : Image à récupérer : http://192.168.1.24:9002/music/current/cover_200x200.jpg?player=b8%3A27%3Aeb%3Aa8%3A42%3A0d&time=0.23630400 1577806051
[2019-12-31 16:27:31.428][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:31.428][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode play'
[2019-12-31 16:27:31.428][DEBUG] : result play
[2019-12-31 16:27:31.428][DEBUG] : Waiting end of TTS mode is play
[2019-12-31 16:27:31.929][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:31.929][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode stop'
[2019-12-31 16:27:31.929][DEBUG] : result stop
[2019-12-31 16:27:31.929][DEBUG] : Finished waiting
[2019-12-31 16:27:31.929][DEBUG] : Set volume to 0 for b827eba8420d
[2019-12-31 16:27:31.929][DEBUG] : sent b8:27:eb:a8:42:0d mixer volume 0
[2019-12-31 16:27:31.931][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode stop'
[2019-12-31 16:27:31.931][DEBUG] : result 
[2019-12-31 16:27:31.931][DEBUG] : Unsyncing b827eba8420d
[2019-12-31 16:27:31.931][DEBUG] : Mode was stop for b827eba8420d
[2019-12-31 16:27:31.931][DEBUG] : Setting playlist for b827eba8420d
[2019-12-31 16:27:31.931][DEBUG] : sent b8:27:eb:a8:42:0d playlistcontrol cmd:load playlist_name:temp_b827eba8420d
[2019-12-31 16:27:31.946][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mixer volume 0'
[2019-12-31 16:27:31.946][DEBUG] : result 
[2019-12-31 16:27:31][DEBUG] : Received : {"volume":"0"} de : b8:27:eb:a8:42:0d
[2019-12-31 16:27:31][INFO] : Volume trop bas je monte
[2019-12-31 16:27:31][DEBUG] : Array (     [device] => b8:27:eb:a8:42:0d     [action] => setVolume     [datafolder] => /var/www/html/plugins/squeezeboxcontrol/core/class/../../data     [jeedompath] => http://192.168.1.10:80     [volume] => 15 ) 
[2019-12-31 16:27:31.955][DEBUG] : Client connected to [127.0.0.1:33850]
[2019-12-31 16:27:31.956][DEBUG] : Message read from socket: b'{"apikey":"aS9uwamNXkTqIxqKij2mCC9atKxL6bmm","cmd":"send","data":{"device":"b8:27:eb:a8:42:0d","action":"setVolume","datafolder":"\/var\/www\/html\/plugins\/squeezeboxcontrol\/core\/class\/..\/..\/data","jeedompath":"http:\/\/192.168.1.10:80","volume":"15"}}'
[2019-12-31 16:27:31.956][DEBUG] : Client disconnected from [127.0.0.1:33850]
[2019-12-31 16:27:32.047][DEBUG] : Setting index for b827eba8420d
[2019-12-31 16:27:32.047][DEBUG] : sent b8:27:eb:a8:42:0d playlist index 0
[2019-12-31 16:27:32.486][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d playlistcontrol cmd%3Aload playlist_name%3Atemp_b827eba8420d count%3A0'
[2019-12-31 16:27:32.486][DEBUG] : result  cmd:load playlist_name:temp_b827eba8420d count:0
[2019-12-31 16:27:32.587][DEBUG] : Seeking position for b827eba8420d
[2019-12-31 16:27:32.587][DEBUG] : sent b8:27:eb:a8:42:0d time 0
[2019-12-31 16:27:32.587][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d playlist index 0   '
[2019-12-31 16:27:32.587][DEBUG] : result ist index 0   
[2019-12-31 16:27:32.587][DEBUG] : Power init was true for b827eba8420d
[2019-12-31 16:27:32.587][DEBUG] : Stopping b827eba8420d
[2019-12-31 16:27:32.587][DEBUG] : sent b8:27:eb:a8:42:0d stop
[2019-12-31 16:27:32.665][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d time 0'
[2019-12-31 16:27:32.665][DEBUG] : result e 0
[2019-12-31 16:27:32.665][DEBUG] : Setting volume to play for b827eba8420d
[2019-12-31 16:27:32.665][DEBUG] : sent b8:27:eb:a8:42:0d mixer volume 15
[2019-12-31 16:27:32.666][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d stop'
[2019-12-31 16:27:32.666][DEBUG] : result 
[2019-12-31 16:27:32.666][DEBUG] : Setting shuffle state for b827eba8420d
[2019-12-31 16:27:32.666][DEBUG] : sent b8:27:eb:a8:42:0d playlist shuffle 0
[2019-12-31 16:27:32.716][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mixer volume 15'
[2019-12-31 16:27:32.716][DEBUG] : result 
[2019-12-31 16:27:32.716][DEBUG] : Setting repeat state for b827eba8420d
[2019-12-31 16:27:32.716][DEBUG] : sent b8:27:eb:a8:42:0d playlist repeat 0
[2019-12-31 16:27:32][DEBUG] : Received : {"volume":"15"} de : b8:27:eb:a8:42:0d
[2019-12-31 16:27:32][DEBUG] : Received : {"shuffle":"0"} de : b8:27:eb:a8:42:0d
[2019-12-31 16:27:32.889][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d playlist shuffle 0'
[2019-12-31 16:27:32.890][DEBUG] : result  0
[2019-12-31 16:27:32.890][DEBUG] : Sync init was -
[2019-12-31 16:27:32.890][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:32][DEBUG] : Received : {"repeat":"0"} de : b8:27:eb:a8:42:0d
[2019-12-31 16:27:32.895][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d playlist repeat 0'
[2019-12-31 16:27:32.895][DEBUG] : result ist repeat 0
[2019-12-31 16:27:32.895][DEBUG] : sent b8:27:eb:a8:42:0d power ?
[2019-12-31 16:27:32.895][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode stop'
[2019-12-31 16:27:32.895][DEBUG] : result top
[2019-12-31 16:27:32.895][ERROR] : Exception on socket : invalid literal for int() with base 10: 'top'
[2019-12-31 16:27:32.996][DEBUG] : Message received in socket JEEDOM_SOCKET_MESSAGE
[2019-12-31 16:27:32.996][DEBUG] : Received command from jeedom : send
[2019-12-31 16:27:32.996][DEBUG] : Sending to device : b8:27:eb:a8:42:0d
[2019-12-31 16:27:32.996][DEBUG] : Connecting to server 192.168.1.24 9090  
[2019-12-31 16:27:32.997][DEBUG] : sent login  
[2019-12-31 16:27:33.733][DEBUG] : b'login ******'
[2019-12-31 16:27:33.733][DEBUG] : result ******
[2019-12-31 16:27:33.733][DEBUG] : sent player count ?
[2019-12-31 16:27:33.735][DEBUG] : b'player count 2'
[2019-12-31 16:27:33.735][DEBUG] : result 2
[2019-12-31 16:27:33.736][DEBUG] : sent player id -1 ?
[2019-12-31 16:27:33.738][DEBUG] : b'player id -1 b8%3A27%3Aeb%3A71%3A1c%3Ac9'
[2019-12-31 16:27:33.738][DEBUG] : result b8:27:eb:71:1c:c9
[2019-12-31 16:27:33.738][DEBUG] : sent player name -1 ?
[2019-12-31 16:27:33.740][DEBUG] : b'player name -1 piCorePlayerC'
[2019-12-31 16:27:33.740][DEBUG] : result piCorePlayerC
[2019-12-31 16:27:33.741][DEBUG] : sent player uuid -1 ?
[2019-12-31 16:27:33.743][DEBUG] : b'player uuid -1 '
[2019-12-31 16:27:33.743][DEBUG] : result 
[2019-12-31 16:27:33.743][DEBUG] : sent player ip -1 ?
[2019-12-31 16:27:33.745][DEBUG] : b'player ip -1 192.168.1.31%3A42148'
[2019-12-31 16:27:33.745][DEBUG] : result 192.168.1.31:42148
[2019-12-31 16:27:33.745][DEBUG] : sent player model -1 ?
[2019-12-31 16:27:33.747][DEBUG] : b'player model -1 squeezelite'
[2019-12-31 16:27:33.747][DEBUG] : result squeezelite
[2019-12-31 16:27:33.747][DEBUG] : sent player displaytype -1 ?
[2019-12-31 16:27:33.749][DEBUG] : b'player displaytype -1 none'
[2019-12-31 16:27:33.749][DEBUG] : result none
[2019-12-31 16:27:33.749][DEBUG] : sent player canpoweroff -1 ?
[2019-12-31 16:27:33.751][DEBUG] : b'player canpoweroff -1 1'
[2019-12-31 16:27:33.752][DEBUG] : result 1
[2019-12-31 16:27:33.752][DEBUG] : sent player isplayer -1 ?
[2019-12-31 16:27:33.754][DEBUG] : b'player isplayer -1 1'
[2019-12-31 16:27:33.754][DEBUG] : result 1
[2019-12-31 16:27:33.754][DEBUG] : sent player connected -1 ?
[2019-12-31 16:27:33.756][DEBUG] : b'player connected -1 %3F'
[2019-12-31 16:27:33.756][DEBUG] : result ?
[2019-12-31 16:27:33.756][DEBUG] : sent player id 0 ?
[2019-12-31 16:27:33.759][DEBUG] : b'player id 0 b8%3A27%3Aeb%3Aa8%3A42%3A0d'
[2019-12-31 16:27:33.759][DEBUG] : result b8:27:eb:a8:42:0d
[2019-12-31 16:27:33.759][DEBUG] : sent player name 0 ?
[2019-12-31 16:27:33.762][DEBUG] : b'player name 0 piCorePlayerB'
[2019-12-31 16:27:33.762][DEBUG] : result piCorePlayerB
[2019-12-31 16:27:33.762][DEBUG] : sent player uuid 0 ?
[2019-12-31 16:27:33.764][DEBUG] : b'player uuid 0 '
[2019-12-31 16:27:33.765][DEBUG] : result 
[2019-12-31 16:27:33.765][DEBUG] : sent player ip 0 ?
[2019-12-31 16:27:33.767][DEBUG] : b'player ip 0 192.168.1.22%3A39736'
[2019-12-31 16:27:33.768][DEBUG] : result 192.168.1.22:39736
[2019-12-31 16:27:33.768][DEBUG] : sent player model 0 ?
[2019-12-31 16:27:33.770][DEBUG] : b'player model 0 squeezelite'
[2019-12-31 16:27:33.770][DEBUG] : result squeezelite
[2019-12-31 16:27:33.770][DEBUG] : sent player displaytype 0 ?
[2019-12-31 16:27:33.773][DEBUG] : b'player displaytype 0 none'
[2019-12-31 16:27:33.773][DEBUG] : result none
[2019-12-31 16:27:33.773][DEBUG] : sent player canpoweroff 0 ?
[2019-12-31 16:27:33.775][DEBUG] : b'player canpoweroff 0 1'
[2019-12-31 16:27:33.775][DEBUG] : result 1
[2019-12-31 16:27:33.775][DEBUG] : sent player isplayer 0 ?
[2019-12-31 16:27:33.777][DEBUG] : b'player isplayer 0 1'
[2019-12-31 16:27:33.777][DEBUG] : result 1
[2019-12-31 16:27:33.777][DEBUG] : sent player connected 0 ?
[2019-12-31 16:27:33.780][DEBUG] : b'player connected 0 %3F'
[2019-12-31 16:27:33.780][DEBUG] : result ?
[2019-12-31 16:27:33.780][DEBUG] : Server connected
[2019-12-31 16:27:33.780][DEBUG] : Executing action
[2019-12-31 16:27:33.780][DEBUG] : Volume set {'device': 'b8:27:eb:a8:42:0d', 'action': 'setVolume', 'player': Player: b8:27:eb:a8:42:0d, 'jeedompath': 'http://192.168.1.10:80', 'volume': '15', 'multitarget': [Player: b8:27:eb:a8:42:0d], 'datafolder': '/var/www/html/plugins/squeezeboxcontrol/core/class/../../data'}
[2019-12-31 16:27:33.780][DEBUG] : sent b8:27:eb:a8:42:0d mixer volume 15
[2019-12-31 16:27:33.786][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mixer volume 15'
[2019-12-31 16:27:33.786][DEBUG] : result 5
[2019-12-31 16:27:33.786][DEBUG] : sent b8:27:eb:a8:42:0d mode ?
[2019-12-31 16:27:33.788][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mode stop'
[2019-12-31 16:27:33.788][DEBUG] : result stop
[2019-12-31 16:27:33.789][DEBUG] : sent b8:27:eb:a8:42:0d power ?
[2019-12-31 16:27:33][DEBUG] : Received : {"volume":"15"} de : b8:27:eb:a8:42:0d
[2019-12-31 16:27:33.790][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d power 1'
[2019-12-31 16:27:33.790][DEBUG] : result 1
[2019-12-31 16:27:33.790][DEBUG] : sent b8:27:eb:a8:42:0d mixer volume ?
[2019-12-31 16:27:33.792][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d mixer volume 15'
[2019-12-31 16:27:33.792][DEBUG] : result 15
[2019-12-31 16:27:33.792][DEBUG] : sent b8:27:eb:a8:42:0d playlist shuffle ?
[2019-12-31 16:27:33.794][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d playlist shuffle 0'
[2019-12-31 16:27:33.794][DEBUG] : result 0
[2019-12-31 16:27:33.794][DEBUG] : sent b8:27:eb:a8:42:0d playlist repeat ?
[2019-12-31 16:27:33.796][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d playlist repeat 0'
[2019-12-31 16:27:33.796][DEBUG] : result 0
[2019-12-31 16:27:33.796][DEBUG] : sent b8:27:eb:a8:42:0d sync ?
[2019-12-31 16:27:33.797][DEBUG] : b'b8%3A27%3Aeb%3Aa8%3A42%3A0d sync -'
[2019-12-31 16:27:33.797][DEBUG] : result -
[2019-12-31 16:27:33.798][DEBUG] : Disconnecting server
[2019-12-31 16:27:33.798][DEBUG] : Server disconnected
[2019-12-31 16:27:33.798][DEBUG] : Send to jeedom :  {'playerstate': {'synced': 'null', 'player': 'b8:27:eb:a8:42:0d', 'repeat': '0', 'shuffle': '0', 'volume': 15, 'statut': 'Stop', 'etat': 'On'}}
[2019-12-31 16:27:33.799][DEBUG] : Starting new HTTP connection (1): 127.0.0.1
[2019-12-31 16:27:33][DEBUG] : Received Player State from daemon Array (     [synced] => null     [player] => b8:27:eb:a8:42:0d     [repeat] => 0     [shuffle] => 0     [volume] => 15     [statut] => Stop     [etat] => On ) 
[2019-12-31 16:27:33.812][DEBUG] : http://127.0.0.1:80 "POST /plugins/squeezeboxcontrol/core/php/jeeSqueezeboxcontrol.php?apikey=aS9uwamNXkTqIxqKij2mCC9atKxL6bmm HTTP/1.1" 200 0