rendered paste body13:25:40 T:13420352 NOTICE: -----------------------------------------------------------------------
13:25:40 T:13420352 NOTICE: Starting XBMC (11.0-PRE Git:20120316-45a316b), Platform: Linux (Ubuntu 11.04, 2.6.38-11-generic i686). Built on Mar 20 2012
13:25:40 T:13420352 NOTICE: special://xbmc/ is mapped to: /usr/local/share/xbmc
13:25:40 T:13420352 NOTICE: special://xbmcbin/ is mapped to: /usr/local/lib/xbmc
13:25:40 T:13420352 NOTICE: special://masterprofile/ is mapped to: /home/mark/.xbmc/userdata
13:25:40 T:13420352 NOTICE: special://home/ is mapped to: /home/mark/.xbmc
13:25:40 T:13420352 NOTICE: special://temp/ is mapped to: /home/mark/.xbmc/temp
13:25:40 T:13420352 NOTICE: The executable running is: /usr/local/lib/xbmc/xbmc.bin
13:25:40 T:13420352 NOTICE: Local hostname: mark-ion
13:25:40 T:13420352 NOTICE: Log File is located: /home/mark/.xbmc/temp/xbmc.log
13:25:40 T:13420352 NOTICE: -----------------------------------------------------------------------
13:25:40 T:13420352 NOTICE: Setup SDL
13:25:40 T:13420352 INFO: Available videomodes (xrandr):
13:25:40 T:13420352 INFO: Number of connected outputs: 1
13:25:40 T:13420352 INFO: Output 'default' has 112 modes
13:25:40 T:13420352 INFO: ID:0x12b Name:1920x1080 Refresh:50.000000 Width:1920 Height:1080
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x12c Name:1920x1080 Refresh:51.000000 Width:1920 Height:1080
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x12d Name:1920x1080 Refresh:52.000000 Width:1920 Height:1080
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x12e Name:1920x1080 Refresh:53.000000 Width:1920 Height:1080
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x12f Name:1920x1080 Refresh:54.000000 Width:1920 Height:1080
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x130 Name:1920x1080 Refresh:55.000000 Width:1920 Height:1080
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x131 Name:1920x1080 Refresh:56.000000 Width:1920 Height:1080
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x132 Name:1920x1080 Refresh:57.000000 Width:1920 Height:1080
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x133 Name:1920x1080 Refresh:58.000000 Width:1920 Height:1080
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x134 Name:1680x1050 Refresh:59.000000 Width:1680 Height:1050
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x135 Name:1680x1050 Refresh:60.000000 Width:1680 Height:1050
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x136 Name:1600x1024 Refresh:61.000000 Width:1600 Height:1024
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x137 Name:1440x900 Refresh:62.000000 Width:1440 Height:900
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x138 Name:1400x1050 Refresh:63.000000 Width:1400 Height:1050
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x139 Name:1400x1050 Refresh:64.000000 Width:1400 Height:1050
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x13a Name:1360x768 Refresh:65.000000 Width:1360 Height:768
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x13b Name:1360x768 Refresh:66.000000 Width:1360 Height:768
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x13c Name:1360x765 Refresh:67.000000 Width:1360 Height:765
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x13d Name:1280x1024 Refresh:68.000000 Width:1280 Height:1024
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x13e Name:1280x1024 Refresh:69.000000 Width:1280 Height:1024
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x13f Name:1280x960 Refresh:70.000000 Width:1280 Height:960
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x140 Name:1280x960 Refresh:71.000000 Width:1280 Height:960
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x141 Name:1280x720 Refresh:72.000000 Width:1280 Height:720
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x142 Name:1280x720 Refresh:73.000000 Width:1280 Height:720
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x143 Name:1152x864 Refresh:74.000000 Width:1152 Height:864
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x144 Name:1152x864 Refresh:75.000000 Width:1152 Height:864
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x145 Name:1152x864 Refresh:76.000000 Width:1152 Height:864
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x146 Name:1152x864 Refresh:77.000000 Width:1152 Height:864
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x147 Name:1152x864 Refresh:78.000000 Width:1152 Height:864
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x148 Name:1152x864 Refresh:79.000000 Width:1152 Height:864
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x149 Name:1152x864 Refresh:80.000000 Width:1152 Height:864
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x14a Name:1024x768 Refresh:81.000000 Width:1024 Height:768
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x14b Name:1024x768 Refresh:82.000000 Width:1024 Height:768
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x14c Name:1024x768 Refresh:83.000000 Width:1024 Height:768
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x14d Name:1024x768 Refresh:84.000000 Width:1024 Height:768
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x14e Name:1024x768 Refresh:85.000000 Width:1024 Height:768
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x14f Name:1024x768 Refresh:86.000000 Width:1024 Height:768
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x150 Name:960x720 Refresh:87.000000 Width:960 Height:720
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x151 Name:960x720 Refresh:88.000000 Width:960 Height:720
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x152 Name:960x600 Refresh:89.000000 Width:960 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x153 Name:960x540 Refresh:90.000000 Width:960 Height:540
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x154 Name:928x696 Refresh:91.000000 Width:928 Height:696
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x155 Name:928x696 Refresh:92.000000 Width:928 Height:696
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x156 Name:896x672 Refresh:93.000000 Width:896 Height:672
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x157 Name:896x672 Refresh:94.000000 Width:896 Height:672
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x158 Name:840x525 Refresh:95.000000 Width:840 Height:525
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x159 Name:840x525 Refresh:96.000000 Width:840 Height:525
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x15a Name:840x525 Refresh:97.000000 Width:840 Height:525
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x15b Name:840x525 Refresh:98.000000 Width:840 Height:525
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x15c Name:840x525 Refresh:99.000000 Width:840 Height:525
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x15d Name:832x624 Refresh:100.000000 Width:832 Height:624
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x15e Name:800x600 Refresh:101.000000 Width:800 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x15f Name:800x600 Refresh:102.000000 Width:800 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x160 Name:800x600 Refresh:103.000000 Width:800 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x161 Name:800x600 Refresh:104.000000 Width:800 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x162 Name:800x600 Refresh:105.000000 Width:800 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x163 Name:800x600 Refresh:106.000000 Width:800 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x164 Name:800x600 Refresh:107.000000 Width:800 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x165 Name:800x600 Refresh:108.000000 Width:800 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x166 Name:800x600 Refresh:109.000000 Width:800 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x167 Name:800x600 Refresh:110.000000 Width:800 Height:600
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x168 Name:800x512 Refresh:111.000000 Width:800 Height:512
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x169 Name:720x576 Refresh:112.000000 Width:720 Height:576
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x16a Name:720x576 Refresh:113.000000 Width:720 Height:576
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x16b Name:720x480 Refresh:114.000000 Width:720 Height:480
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x16c Name:720x480 Refresh:115.000000 Width:720 Height:480
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x16d Name:720x450 Refresh:116.000000 Width:720 Height:450
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x16e Name:720x400 Refresh:117.000000 Width:720 Height:400
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x16f Name:700x525 Refresh:118.000000 Width:700 Height:525
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x170 Name:700x525 Refresh:119.000000 Width:700 Height:525
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x171 Name:700x525 Refresh:120.000000 Width:700 Height:525
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x172 Name:700x525 Refresh:121.000000 Width:700 Height:525
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x173 Name:680x384 Refresh:122.000000 Width:680 Height:384
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x174 Name:680x384 Refresh:123.000000 Width:680 Height:384
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x175 Name:640x512 Refresh:124.000000 Width:640 Height:512
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x176 Name:640x512 Refresh:125.000000 Width:640 Height:512
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x177 Name:640x512 Refresh:126.000000 Width:640 Height:512
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x178 Name:640x480 Refresh:127.000000 Width:640 Height:480
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x179 Name:640x480 Refresh:128.000000 Width:640 Height:480
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x17a Name:640x480 Refresh:129.000000 Width:640 Height:480
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x17b Name:640x480 Refresh:130.000000 Width:640 Height:480
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x17c Name:640x480 Refresh:131.000000 Width:640 Height:480
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x17d Name:640x480 Refresh:132.000000 Width:640 Height:480
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x17e Name:640x480 Refresh:133.000000 Width:640 Height:480
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x17f Name:640x480 Refresh:134.000000 Width:640 Height:480
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x180 Name:640x400 Refresh:135.000000 Width:640 Height:400
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x181 Name:640x350 Refresh:136.000000 Width:640 Height:350
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x182 Name:576x432 Refresh:137.000000 Width:576 Height:432
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x183 Name:576x432 Refresh:138.000000 Width:576 Height:432
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x184 Name:576x432 Refresh:139.000000 Width:576 Height:432
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x185 Name:576x432 Refresh:140.000000 Width:576 Height:432
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x186 Name:576x432 Refresh:141.000000 Width:576 Height:432
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x187 Name:576x432 Refresh:142.000000 Width:576 Height:432
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x188 Name:576x432 Refresh:143.000000 Width:576 Height:432
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x189 Name:512x384 Refresh:144.000000 Width:512 Height:384
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x18a Name:512x384 Refresh:145.000000 Width:512 Height:384
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x18b Name:512x384 Refresh:146.000000 Width:512 Height:384
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x18c Name:512x384 Refresh:147.000000 Width:512 Height:384
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x18d Name:512x384 Refresh:148.000000 Width:512 Height:384
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x18e Name:416x312 Refresh:149.000000 Width:416 Height:312
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x18f Name:400x300 Refresh:150.000000 Width:400 Height:300
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x190 Name:400x300 Refresh:151.000000 Width:400 Height:300
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x191 Name:400x300 Refresh:152.000000 Width:400 Height:300
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x192 Name:400x300 Refresh:153.000000 Width:400 Height:300
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x193 Name:400x300 Refresh:154.000000 Width:400 Height:300
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x194 Name:360x200 Refresh:155.000000 Width:360 Height:200
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x195 Name:320x240 Refresh:156.000000 Width:320 Height:240
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x196 Name:320x240 Refresh:157.000000 Width:320 Height:240
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x197 Name:320x240 Refresh:158.000000 Width:320 Height:240
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x198 Name:320x240 Refresh:159.000000 Width:320 Height:240
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x199 Name:320x200 Refresh:160.000000 Width:320 Height:200
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 INFO: ID:0x19a Name:320x175 Refresh:161.000000 Width:320 Height:175
13:25:40 T:13420352 INFO: Pixel Ratio: 1.000000
13:25:40 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.ConsoleKit on /org/freedesktop/ConsoleKit/Manager with interface org.freedesktop.ConsoleKit.Manager and method CanStop
13:25:40 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UPower on /org/freedesktop/UPower with interface org.freedesktop.UPower and method EnumerateDevices
13:25:40 T:13420352 INFO: Selected UPower and ConsoleKit as PowerSyscall
13:25:40 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.ConsoleKit on /org/freedesktop/ConsoleKit/Manager with interface org.freedesktop.ConsoleKit.Manager and method CanStop
13:25:40 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.ConsoleKit on /org/freedesktop/ConsoleKit/Manager with interface org.freedesktop.ConsoleKit.Manager and method CanRestart
13:25:40 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UPower on /org/freedesktop/UPower with interface org.freedesktop.DBus.Properties and method Get
13:25:40 T:13420352 DEBUG: Previous line repeats 1 times.
13:25:40 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UPower on /org/freedesktop/UPower with interface org.freedesktop.UPower and method EnumerateDevices
13:25:40 T:13420352 NOTICE: load settings...
13:25:40 T:13420352 DEBUG: SECTION:LoadDLL(libcrystalhd.so.3)
13:25:40 T:13420352 DEBUG: Loading: libcrystalhd.so.3
13:26:02 T:13420352 DEBUG: CrystalHD: device open failed , returning(0xa)
13:26:02 T:13420352 DEBUG: CrystalHD: broadcom crystal hd not found
13:26:02 T:13420352 NOTICE: special://profile/ is mapped to: special://masterprofile/
13:26:02 T:13420352 NOTICE: loading special://masterprofile/guisettings.xml
13:26:03 T:13420352 NOTICE: Getting hardware information now...
13:26:03 T:13420352 INFO: Using digital output
13:26:03 T:13420352 INFO: AC3 pass through is disabled
13:26:03 T:13420352 INFO: DTS pass through is disabled
13:26:03 T:13420352 INFO: AAC pass through is disabled
13:26:03 T:13420352 INFO: MP1 pass through is disabled
13:26:03 T:13420352 INFO: MP2 pass through is disabled
13:26:03 T:13420352 INFO: MP3 pass through is disabled
13:26:03 T:13420352 NOTICE: Checking resolution 12
13:26:03 T:13420352 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
13:26:03 T:13420352 DEBUG: CPlayerCoreConfig::<ctor>: created player DVDPlayer for core 1
13:26:03 T:13420352 DEBUG: CPlayerCoreConfig::<ctor>: created player oldmplayercore for core 1
13:26:03 T:13420352 DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer for core 3
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtv
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/myth/rtmp/mms/udp
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: flv/aacp/sdp
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdfile
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
13:26:03 T:13420352 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
13:26:03 T:13420352 NOTICE: Loaded playercorefactory configuration
13:26:03 T:13420352 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
13:26:03 T:13420352 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
13:26:03 T:13420352 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
13:26:03 T:13420352 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
13:26:03 T:13420352 NOTICE: Default DVD Player: dvdplayer
13:26:03 T:13420352 NOTICE: Default Video Player: dvdplayer
13:26:03 T:13420352 NOTICE: Default Audio Player: paplayer
13:26:03 T:13420352 NOTICE: Disabled debug logging due to GUI setting. Level 1.
13:26:03 T:13420352 NOTICE: Log level changed to 1
13:26:03 T:13420352 NOTICE: Loading media sources from special://masterprofile/sources.xml
13:26:03 T:13420352 INFO: creating subdirectories
13:26:03 T:13420352 INFO: userdata folder: special://masterprofile/
13:26:03 T:13420352 INFO: recording folder:
13:26:03 T:13420352 INFO: screenshots folder:
13:26:03 T:13420352 INFO: thumbnails folder: special://masterprofile/Thumbnails
13:26:03 T:13420352 INFO: load language info file: special://xbmc/language/English/langinfo.xml
13:26:03 T:13420352 DEBUG: trying to set locale to en_AU.UTF-8
13:26:03 T:13420352 INFO: global locale set to en_AU.UTF-8
13:26:03 T:13420352 INFO: load language file:special://xbmc/language/English/strings.xml
13:26:03 T:13420352 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcpluff-i486-linux.so)
13:26:03 T:13420352 DEBUG: Loading: /usr/local/lib/xbmc/system/libcpluff-i486-linux.so
13:26:03 T:13420352 INFO: ADDON: cpluff: 'Could not read plug-in directory /usr/local/lib/xbmc/addons: No such file or directory'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in script.module.xbmcswift has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.albums.allmusic.com has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in plugin.audio.icecast has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in plugin.video.ted.talks has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.allmusic.com has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in plugin.audio.radio_de has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in script.module.beautifulsoup has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in visualization.milkdrop has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in visualization.dxspectrum has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in pvr.demo has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.slideshow has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in pvr.team-mediaportal.tvserver has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.yahoomusic.com has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in script.module.elementtree has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in script.module.pysqlite has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in visualization.itunes has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.'
13:26:03 T:13420352 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
13:26:03 T:13420352 DEBUG: LoadMappings - loaded node "Motorola Nyxboard Hybrid"
13:26:03 T:13420352 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
13:26:03 T:13420352 DEBUG: CPeripheralBusUSB - initialised udev monitor: 13
13:26:03 T:13420352 DEBUG: GetMappingForDevice - device (2548:1001) mapped to Pulse-Eight CEC Adapter (type = cec)
13:26:03 T:13420352 DEBUG: SECTION:LoadDLL(libcec.so.1)
13:26:03 T:13420352 DEBUG: Loading: libcec.so.1
13:26:03 T:13420352 DEBUG: InitialiseFeature - using libCEC vUnknown
13:26:03 T:13420352 DEBUG: Initialise - initialised peripheral on '/sys/devices/pci0000:00/0000:00:06.0/usb4/4-4' with 2 features and 0 sub devices
13:26:03 T:13420352 NOTICE: Register - new nic device registered on usb->/sys/devices/pci0000:00/0000:00:06.0/usb4/4-4: Pulse-Eight CEC Adapter (2548:1001)
13:26:03 T:35609456 DEBUG: Thread CEC Adapter start, auto delete: 0
13:26:03 T:3079535472 DEBUG: Thread XBMC Peripherals start, auto delete: 0
13:26:03 T:13420352 INFO: LIRC Initialize: using: /dev/lircd
13:26:03 T:13420352 INFO: LIRC Initialize: connect failed: No such file or directory
13:26:03 T:13420352 DEBUG: Failed to connect to LIRC. Retry in 10s.
13:26:03 T:35609456 DEBUG: CecLogMessage - trying to autodetect the com port for device path '/sys/devices/pci0000:00/0000:00:06.0/usb4/4-4'
13:26:03 T:13420352 DEBUG: OnLostDevice - notify display change event
13:26:03 T:13420352 INFO: XRANDR: /usr/local/lib/xbmc/xbmc-xrandr --output default --mode 0x12c
13:26:03 T:35609456 DEBUG: GetComPort - autodetect com port '/dev/ttyACM0'
13:26:03 T:35609456 DEBUG: OpenConnection - opening a connection to the CEC adapter: /dev/ttyACM0
13:26:03 T:35609456 DEBUG: CecLogMessage - connection opened, clearing any previous input and waiting for active transmissions to end before starting
13:26:03 T:35609456 DEBUG: CecLogMessage - sending ping
13:26:03 T:35609456 DEBUG: CecLogMessage - command sent
13:26:03 T:35609456 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:03 T:35609456 DEBUG: CecLogMessage - requesting the firmware version
13:26:03 T:35609456 DEBUG: CecLogMessage - command sent
13:26:03 T:13420352 NOTICE: Using visual 0x42
13:26:03 T:13420352 INFO: GL: Maximum texture width: 8192
13:26:03 T:13420352 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-i486-linux.so)
13:26:03 T:13420352 DEBUG: Loading: /usr/local/lib/xbmc/system/ImageLib-i486-linux.so
13:26:03 T:13420352 DEBUG: GLX_EXTENSIONS: GLX_EXT_visual_info GLX_EXT_visual_rating GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGI_video_sync GLX_SGI_swap_control GLX_EXT_swap_control GLX_EXT_texture_from_pixmap GLX_ARB_create_context GLX_ARB_create_context_profile GLX_EXT_create_context_es2_profile GLX_ARB_create_context_robustness GLX_ARB_multisample GLX_NV_float_buffer GLX_ARB_fbconfig_float GLX_EXT_framebuffer_sRGB GLX_ARB_get_proc_address
13:26:03 T:13420352 NOTICE: GL_VENDOR = NVIDIA Corporation
13:26:03 T:13420352 NOTICE: GL_RENDERER = ION/PCI/SSE2
13:26:03 T:13420352 NOTICE: GL_VERSION = 3.3.0 NVIDIA 270.41.06
13:26:03 T:13420352 NOTICE: GL_SHADING_LANGUAGE_VERSION = 3.30 NVIDIA via Cg compiler
13:26:03 T:13420352 NOTICE: GL_GPU_MEMORY_INFO_TOTAL_AVAILABLE_MEMORY_NVX = 524288
13:26:03 T:13420352 NOTICE: GL_GPU_MEMORY_INFO_DEDICATED_VIDMEM_NVX = 262144
13:26:03 T:13420352 NOTICE: GL_EXTENSIONS = GL_ARB_blend_func_extended GL_ARB_color_buffer_float GL_ARB_compatibility GL_ARB_copy_buffer GL_ARB_depth_buffer_float GL_ARB_depth_clamp GL_ARB_depth_texture GL_ARB_draw_buffers GL_ARB_draw_elements_base_vertex GL_ARB_draw_instanced GL_ARB_ES2_compatibility GL_ARB_explicit_attrib_location GL_ARB_fragment_coord_conventions GL_ARB_fragment_program GL_ARB_fragment_program_shadow GL_ARB_fragment_shader GL_ARB_framebuffer_object GL_ARB_framebuffer_sRGB GL_ARB_geometry_shader4 GL_ARB_get_program_binary GL_ARB_half_float_pixel GL_ARB_half_float_vertex GL_ARB_imaging GL_ARB_instanced_arrays GL_ARB_map_buffer_range GL_ARB_multisample GL_ARB_multitexture GL_ARB_occlusion_query GL_ARB_occlusion_query2 GL_ARB_pixel_buffer_object GL_ARB_point_parameters GL_ARB_point_sprite GL_ARB_provoking_vertex GL_ARB_robustness GL_ARB_sampler_objects GL_ARB_seamless_cube_map GL_ARB_separate_shader_objects GL_ARB_shader_bit_encoding GL_ARB_shader_objects GL_ARB_shading_language_100 GL_ARB_shading_language_include GL_ARB_shadow GL_ARB_sync GL_ARB_texture_border_clamp GL_ARB_texture_buffer_object GL_ARB_texture_compression GL_ARB_texture_compression_rgtc GL_ARB_texture_cube_map GL_ARB_texture_env_add GL_ARB_texture_env_combine GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_float GL_ARB_texture_mirrored_repeat GL_ARB_texture_multisample GL_ARB_texture_non_power_of_two GL_ARB_texture_rectangle GL_ARB_texture_rg GL_ARB_texture_rgb10_a2ui GL_ARB_texture_swizzle GL_ARB_timer_query GL_ARB_transform_feedback2 GL_ARB_transpose_matrix GL_ARB_uniform_buffer_object GL_ARB_vertex_array_bgra GL_ARB_vertex_array_object GL_ARB_vertex_buffer_object GL_ARB_vertex_program GL_ARB_vertex_shader GL_ARB_vertex_type_2_10_10_10_rev GL_ARB_viewport_array GL_ARB_window_pos GL_ATI_draw_buffers GL_ATI_texture_float GL_ATI_texture_mirror_once GL_S3_s3tc GL_EXT_texture_env_add GL_EXT_abgr GL_EXT_bgra GL_EXT_bindable_uniform GL_EXT_blend_color GL_EXT_blend_equation_separate GL_EXT_blend_func_separate GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_compiled_vertex_array GL_EXT_Cg_shader GL_EXT_depth_bounds_test GL_EXT_direct_state_access GL_EXT_draw_buffers2 GL_EXT_draw_instanced GL_EXT_draw_range_elements GL_EXT_fog_coord GL_EXT_framebuffer_blit GL_EXT_framebuffer_multisample GL_EXTX_framebuffer_mixed_formats GL_EXT_framebuffer_object GL_EXT_framebuffer_sRGB GL_EXT_geometry_shader4 GL_EXT_gpu_program_parameters GL_EXT_gpu_shader4 GL_EXT_multi_draw_arrays GL_EXT_packed_depth_stencil GL_EXT_packed_float GL_EXT_packed_pixels GL_EXT_pixel_buffer_object GL_EXT_point_parameters GL_EXT_provoking_vertex GL_EXT_rescale_normal GL_EXT_secondary_color GL_EXT_separate_shader_objects GL_EXT_separate_specular_color GL_EXT_shadow_funcs GL_EXT_stencil_two_side GL_EXT_stencil_wrap GL_EXT_texture3D GL_EXT_texture_array GL_EXT_texture_buffer_object GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_latc GL_EXT_texture_compression_rgtc GL_EXT_texture_compression_s3tc GL_EXT_texture_cube_map GL_EXT_texture_edge_clamp GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_EXT_texture_filter_anisotropic GL_EXT_texture_format_BGRA8888 GL_EXT_texture_integer GL_EXT_texture_lod GL_EXT_texture_lod_bias GL_EXT_texture_mirror_clamp GL_EXT_texture_object GL_EXT_texture_shared_exponent GL_EXT_texture_sRGB GL_EXT_texture_swizzle GL_EXT_texture_type_2_10_10_10_REV GL_EXT_timer_query GL_EXT_transform_feedback2 GL_EXT_vertex_array GL_EXT_vertex_array_bgra GL_IBM_rasterpos_clip GL_IBM_texture_mirrored_repeat GL_KTX_buffer_region GL_NV_alpha_test GL_NV_blend_minmax GL_NV_blend_square GL_NV_complex_primitives GL_NV_conditional_render GL_NV_copy_depth_to_color GL_NV_copy_image GL_NV_depth_buffer_float GL_NV_depth_clamp GL_NV_explicit_multisample GL_NV_fbo_color_attachments GL_NV_fence GL_NV_float_buffer GL_NV_fog_distance GL_NV_fragdepth GL_NV_fragment_program GL_NV_fragment_program_option GL_NV_fragment_program2 GL_NV_framebuffer_multisample_coverage GL_NV_geometry_shader4 GL_NV_gpu_program4 GL_NV_half_float GL_NV_light_max_exponent GL_NV_multisample_coverage GL_NV_multisample_filter_hint GL_NV_occlusion_query GL_NV_packed_depth_stencil GL_NV_parameter_buffer_object GL_NV_parameter_buffer_object2 GL_NV_pixel_data_range GL_NV_point_sprite GL_NV_primitive_restart GL_NV_register_combiners GL_NV_register_combiners2 GL_NV_shader_buffer_load GL_NV_texgen_reflection GL_NV_texture_barrier GL_NV_texture_compression_vtc GL_NV_texture_env_combine4 GL_NV_texture_expand_normal GL_NV_texture_lod_clamp GL_NV_texture_multisample GL_NV_texture_rectangle GL_NV_texture_shader GL_NV_texture_shader2 GL_NV_texture_shader3 GL_NV_transform_feedback GL_NV_transform_feedback2 GL_NV_vdpau_interop GL_NV_vertex_array_range GL_NV_vertex_array_range2 GL_NV_vertex_buffer_unified_memory GL_NV_vertex_program GL_NV_vertex_program1_1 GL_NV_vertex_program2 GL_NV_vertex_program2_option GL_NV_vertex_program3 GL_NVX_conditional_render GL_NVX_gpu_memory_info GL_OES_depth24 GL_OES_depth32 GL_OES_depth_texture GL_OES_element_index_uint GL_OES_fbo_render_mipmap GL_OES_get_program_binary GL_OES_mapbuffer GL_OES_packed_depth_stencil GL_OES_rgb8_rgba8 GL_OES_standard_derivatives GL_OES_texture_3D GL_OES_texture_float GL_OES_texture_float_linear GL_OES_texture_half_float GL_OES_texture_half_float_linear GL_OES_texture_npot GL_OES_vertex_array_object GL_OES_vertex_half_float GL_SGIS_generate_mipmap GL_SGIS_texture_lod GL_SGIX_depth_texture GL_SGIX_shadow GL_SUN_slice_accum
13:26:03 T:13420352 DEBUG: OnLostDevice - notify display change event
13:26:03 T:13420352 ERROR: GLX: Same window as before, refreshing context
13:26:03 T:13420352 INFO: GL: Maximum texture width: 8192
13:26:03 T:13420352 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
13:26:03 T:13420352 INFO: load default splash image: /usr/local/share/xbmc/media/Splash.png
13:26:03 T:35609456 DEBUG: CecLogMessage - firmware version 2
13:26:03 T:35609456 DEBUG: CecLogMessage - turning controlled mode on
13:26:03 T:35609456 DEBUG: CecLogMessage - command sent
13:26:03 T:35609456 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:03 T:35609456 DEBUG: CecLogMessage - communication thread started
13:26:03 T:35609456 DEBUG: CecLogMessage - connected to the CEC adapter. firmware version = 2, client version = 1.5.1
13:26:03 T:35609456 DEBUG: CecLogMessage - requesting device type setting
13:26:03 T:35609456 DEBUG: CecLogMessage - command sent
13:26:03 T:13420352 DEBUG: CheckDisplayEvents: Received RandR event 123
13:26:03 T:13420352 DEBUG: CheckDisplayEvents - notify display reset event
13:26:03 T:13420352 INFO: load keymapping
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/appcommand.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/gamepad.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/keyboard.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/mouse.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/keymaps/remote.xml
13:26:03 T:13420352 INFO: Loading special://xbmc/system/Lircmap.xml
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'mceusb'
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'XboxDVDDongle'
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'Microsoft_Xbox'
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'anysee'
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'iMON-PAD'
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'Antec_Veris_RM200'
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'MCE_via_iMON'
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'TwinHanRemote'
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'linux-input-layer'
13:26:03 T:13420352 INFO: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
13:26:03 T:13420352 INFO: * Linking remote mapping for 'linux-input-layer' to 'devinput'
13:26:03 T:13420352 INFO: * Adding remote mapping for device 'mediacenter'
13:26:03 T:13420352 DEBUG: CButtonTranslator::Load - no userdata Lircmap.xml found, skipping
13:26:03 T:13420352 INFO: GUI format 1920x1080 1920x1080 @ 51.00 - Full Screen
13:26:03 T:13420352 DEBUG: guilib: Fill viewport always for solving rendering passes
13:26:03 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks with interface org.freedesktop.UDisks and method EnumerateDevices
13:26:03 T:13420352 DEBUG: Selected UDisks as storage provider
13:26:03 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks with interface org.freedesktop.DBus.Properties and method Get
13:26:03 T:13420352 DEBUG: UDisks: DaemonVersion 1
13:26:03 T:13420352 DEBUG: UDisks: Querying available devices
13:26:03 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks with interface org.freedesktop.UDisks and method EnumerateDevices
13:26:03 T:13420352 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda)
13:26:03 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method GetAll
13:26:03 T:13420352 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition false IsOptical false
13:26:03 T:13420352 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda1)
13:26:03 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda1 with interface org.freedesktop.DBus.Properties and method GetAll
13:26:03 T:35609456 DEBUG: CecLogMessage - using persisted device type setting playback device
13:26:03 T:35609456 DEBUG: CecLogMessage - requesting physical address setting
13:26:03 T:35609456 DEBUG: CecLogMessage - command sent
13:26:03 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method Get
13:26:03 T:13420352 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda1: IsFileSystem true HasFileSystem ext4 IsSystemInternal true IsMounted true IsRemovable false IsPartition true IsOptical false
13:26:03 T:13420352 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda2)
13:26:03 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda2 with interface org.freedesktop.DBus.Properties and method GetAll
13:26:03 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method Get
13:26:03 T:13420352 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda2: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false
13:26:03 T:13420352 DEBUG: UDisks: DeviceAdded (/org/freedesktop/UDisks/devices/sda5)
13:26:03 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda5 with interface org.freedesktop.DBus.Properties and method GetAll
13:26:03 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UDisks on /org/freedesktop/UDisks/devices/sda with interface org.freedesktop.DBus.Properties and method Get
13:26:03 T:13420352 DEBUG: UDisks: DeviceAdded - DeviceUDI /org/freedesktop/UDisks/devices/sda5: IsFileSystem false HasFileSystem IsSystemInternal true IsMounted false IsRemovable false IsPartition true IsOptical false
13:26:03 T:13420352 DEBUG: SECTION:LoadDLL(libcurl-gnutls.so.4)
13:26:03 T:13420352 DEBUG: Loading: libcurl-gnutls.so.4
13:26:03 T:13420352 NOTICE: start dvd mediatype detection
13:26:03 T:13420352 NOTICE: initializing playlistplayer
13:26:03 T:13420352 NOTICE: DONE initializing playlistplayer
13:26:03 T:37415792 DEBUG: Thread CDetectDVDMedia start, auto delete: 0
13:26:03 T:37415792 DEBUG: Compiled with libcdio Version 0.81
13:26:03 T:13420352 DEBUG: DPMS: supported power-saving modes: SUSPEND OFF STANDBY
13:26:03 T:37415792 DEBUG: Thread CDetectDVDMedia 37415792 terminating
13:26:03 T:13420352 INFO: Unloading old skin ...
13:26:03 T:13420352 INFO: load skin from:/usr/local/share/xbmc/addons/skin.confluence
13:26:03 T:13420352 INFO: load fonts for skin...
13:26:03 T:13420352 INFO: Loading fonts from /usr/local/share/xbmc/addons/skin.confluence/720p/Font.xml
13:26:03 T:13420352 INFO: Loading skin includes from /usr/local/share/xbmc/addons/skin.confluence/720p/includes.xml
13:26:04 T:35609456 DEBUG: CecLogMessage - using persisted physical address setting 0
13:26:04 T:35609456 DEBUG: CecLogMessage - requesting OSD name setting
13:26:04 T:35609456 DEBUG: CecLogMessage - command sent
13:26:04 T:13420352 INFO: load new skin...
13:26:04 T:13420352 INFO: Loading skin file: Home.xml
13:26:04 T:13420352 DEBUG: Load Home.xml: 89.59ms
13:26:04 T:13420352 INFO: Loading user windows, path /usr/local/share/xbmc/addons/skin.confluence/720p
13:26:04 T:13420352 DEBUG: Load Skin XML: 115.04ms
13:26:04 T:13420352 INFO: initialize new skin...
13:26:04 T:13420352 DEBUG: guilib: Fill viewport always for solving rendering passes
13:26:04 T:13420352 INFO: Loading skin file: Pointer.xml
13:26:04 T:13420352 DEBUG: Load Pointer.xml: 3.06ms
13:26:04 T:13420352 INFO: Loading skin file: DialogVolumeBar.xml
13:26:04 T:13420352 DEBUG: Load DialogVolumeBar.xml: 4.24ms
13:26:04 T:13420352 INFO: Loading skin file: DialogKaiToast.xml
13:26:04 T:13420352 DEBUG: Load DialogKaiToast.xml: 4.33ms
13:26:04 T:13420352 INFO: Loading skin file: DialogMuteBug.xml
13:26:04 T:13420352 DEBUG: Load DialogMuteBug.xml: 2.86ms
13:26:04 T:13420352 INFO: Loading skin file: DialogSeekBar.xml
13:26:04 T:13420352 DEBUG: Load DialogSeekBar.xml: 12.40ms
13:26:04 T:13420352 INFO: Loading skin file: DialogBusy.xml
13:26:04 T:13420352 DEBUG: Load DialogBusy.xml: 3.12ms
13:26:04 T:13420352 DEBUG: CGUIAudioManager::Initialize
13:26:04 T:13420352 INFO: Loading /usr/local/share/xbmc/addons/skin.confluence/sounds/sounds.xml
13:26:04 T:13420352 INFO: skin loaded...
13:26:04 T:13420352 INFO: JSONRPC: Sucessfully initialized
13:26:04 T:13420352 DEBUG: ADDON: Starting service addons.
13:26:04 T:13420352 DEBUG: Activating window ID: 12999
13:26:04 T:13420352 DEBUG: ------ Window Init (Startup.xml) ------
13:26:04 T:13420352 INFO: Loading skin file: Startup.xml
13:26:04 T:13420352 DEBUG: Load Startup.xml: 3.65ms
13:26:04 T:13420352 DEBUG: Alloc resources: 3.78ms (3.78 ms skin load)
13:26:04 T:13420352 INFO: removing tempfiles
13:26:04 T:13420352 DEBUG: ADDON: Starting service addons.
13:26:04 T:13420352 NOTICE: initialize done
13:26:04 T:13420352 NOTICE: Running the application...
13:26:04 T:13420352 DEBUG: ExecuteXBMCAction : Translating ReplaceWindow(Home)
13:26:04 T:13420352 DEBUG: ExecuteXBMCAction : To ReplaceWindow(Home)
13:26:04 T:13420352 DEBUG: Activating window ID: 10000
13:26:04 T:13420352 DEBUG: OpenBundle - Opened bundle /usr/local/share/xbmc/addons/skin.confluence/media/Textures.xbt
13:26:04 T:3037723504 DEBUG: Thread Jobworker start, auto delete: 1
13:26:04 T:13420352 DEBUG: ------ Window Init (Pointer.xml) ------
13:26:04 T:13420352 DEBUG: Alloc resources: 0.54ms (0.01 ms skin load)
13:26:04 T:13420352 INFO: GL: Enabling VSYNC
13:26:04 T:13420352 INFO: GL: Selected vsync mode 2
13:26:04 T:13420352 DEBUG: ------ Window Deinit (Startup.xml) ------
13:26:04 T:13420352 DEBUG: ------ Window Init (Home.xml) ------
13:26:04 T:13420352 DEBUG: Alloc resources: 3.70ms (0.01 ms skin load)
13:26:04 T:2955930480 DEBUG: Thread Jobworker start, auto delete: 1
13:26:04 T:2955930480 DEBUG: Previous line repeats 1 times.
13:26:04 T:2955930480 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
13:26:04 T:13420352 DEBUG: Process - no profile autoexec.py (/home/mark/.xbmc/userdata/autoexec.py) found, skipping
13:26:04 T:13420352 DEBUG: NetworkMessage - Starting network services
13:26:04 T:13420352 NOTICE: ES: Starting event server
13:26:04 T:2939145072 DEBUG: Thread CEventServer start, auto delete: 0
13:26:04 T:2939145072 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
13:26:04 T:13420352 INFO: JSONRPC Server: Successfully initialized
13:26:04 T:2939145072 NOTICE: UDP: Listening on port 9777
13:26:04 T:2930752368 DEBUG: Thread JSONRPC::CTCPServer start, auto delete: 0
13:26:04 T:2947537776 INFO: WEATHER: Downloading weather
13:26:04 T:2947537776 INFO: initializing python engine.
13:26:04 T:2955930480 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.* FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum
13:26:04 T:2955930480 DEBUG: GetRecentlyAddedAlbums query: select * from albumview order by idAlbum desc limit 10
13:26:04 T:2939145072 DEBUG: CZeroconfAvahi::clientCallback: client is up and running
13:26:04 T:2955930480 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
13:26:04 T:13420352 NOTICE: starting zeroconf publishing
13:26:04 T:13420352 DEBUG: CLastfmScrobbler: Clearing session.
13:26:04 T:13420352 DEBUG: CLibrefmScrobbler: Clearing session.
13:26:04 T:2913966960 DEBUG: Thread Jobworker start, auto delete: 1
13:26:04 T:2955930480 DEBUG: RunQuery took 2 ms for 0 items query: select * from movieview order by idMovie desc limit 10
13:26:04 T:2955930480 DEBUG: RunQuery took 2 ms for 0 items query: select * from episodeview order by idEpisode desc limit 10
13:26:04 T:2955930480 DEBUG: GetMusicVideosByWhere query = select * from musicvideoview order by idMVideo desc limit 10
13:26:04 T:2955930480 DEBUG: GetMusicVideosByWhere time for actual SQL query = 2
13:26:04 T:2955930480 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
13:26:04 T:2947537776 DEBUG: new python thread created. id=1
13:26:04 T:2905574256 DEBUG: Thread XBPyThread start, auto delete: 0
13:26:04 T:2905574256 DEBUG: Python thread: start processing
13:26:04 T:2905574256 NOTICE: -->Python Interpreter Initialized<--
13:26:04 T:2905574256 DEBUG: Process - The source file to load is /home/mark/.xbmc/addons/weather.wunderground/default.py
13:26:04 T:2905574256 DEBUG: Process - Setting the Python path to /home/mark/.xbmc/addons/weather.wunderground:/home/mark/.xbmc/addons/script.module.xbmcswift/lib:/usr/local/share/xbmc/addons/script.module.simplejson/lib:/home/mark/.xbmc/addons/script.module.beautifulsoup/lib:/usr/local/share/xbmc/addons/script.module.pil/lib:/home/mark/.xbmc/addons/script.module.elementtree/lib:/usr/local/share/xbmc/addons/script.module.pysqlite/lib:/usr/lib/python2.7:/usr/lib/python2.7/plat-linux2:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PIL:/usr/lib/pymodules/python2.7/gtk-2.0:/usr/lib/python2.7/dist-packages/gst-0.10:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/pymodules/python2.7:/usr/lib/pymodules/python2.7/ubuntuone-client:/usr/lib/pymodules/python2.7/ubuntuone-control-panel:/usr/lib/pymodules/python2.7/ubuntuone-storage-protocol:
13:26:04 T:2905574256 DEBUG: Process - Entering source directory /home/mark/.xbmc/addons/weather.wunderground
13:26:04 T:2905574256 DEBUG: Instantiating addon using automatically obtained id of "weather.wunderground" dependent on version 2.0 of the xbmc.python api
13:26:04 T:3037723504 DEBUG: DoWork - took 251 ms to load special://skin/backgrounds/videos.jpg
13:26:04 T:3037723504 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:XBMC (mark-ion) port:9777
13:26:04 T:3037723504 DEBUG: CZeroconfAvahi::addService() named: XBMC (mark-ion) type: _xbmc-events._udp port:9777
13:26:04 T:3037723504 DEBUG: CZeroconfAvahi::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:XBMC (mark-ion) port:9090
13:26:04 T:3037723504 DEBUG: CZeroconfAvahi::addService() named: XBMC (mark-ion) type: _xbmc-jsonrpc._tcp port:9090
13:26:04 T:2913966960 DEBUG: DoWork - took 286 ms to load special://skin/backgrounds/videos.jpg
13:26:04 T:13420352 DEBUG: UPower: Recieved an unknown signal NameAcquired
13:26:05 T:2922359664 DEBUG: CZeroconfAvahi::groupCallback: Service successfully established
13:26:06 T:35609456 DEBUG: Previous line repeats 1 times.
13:26:06 T:35609456 DEBUG: CecLogMessage - using persisted device name setting CXBMC
13:26:06 T:2893491056 DEBUG: CecLogMessage - processor thread started
13:26:06 T:35609456 DEBUG: CecLogMessage - FindLogicalAddresses - device 0: type 4
13:26:06 T:35609456 DEBUG: CecLogMessage - detecting logical address for type 'playback device'
13:26:06 T:35609456 DEBUG: CecLogMessage - trying logical address 'Playback 1'
13:26:06 T:35609456 DEBUG: CecLogMessage - setting ackmask to 0
13:26:06 T:35609456 DEBUG: CecLogMessage - command sent
13:26:06 T:35609456 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:06 T:35609456 DEBUG: CecLogMessage - << Playback 1 (4) -> Playback 1 (4): POLL
13:26:06 T:35609456 DEBUG: CecLogMessage - << 44
13:26:06 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:06 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:06 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:06 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:06 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:06 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:06 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_FAILED_ACK
13:26:06 T:3067083632 DEBUG: CecLogMessage - did not receive ack
13:26:06 T:35609456 DEBUG: CecLogMessage - command was not acked
13:26:06 T:35609456 DEBUG: CecLogMessage - << 44
13:26:06 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:06 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:06 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:06 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:06 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:06 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:06 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_FAILED_ACK
13:26:06 T:3067083632 DEBUG: CecLogMessage - did not receive ack
13:26:06 T:35609456 DEBUG: CecLogMessage - command was not acked
13:26:07 T:35609456 DEBUG: CecLogMessage - >> POLL not sent
13:26:07 T:35609456 DEBUG: CecLogMessage - using logical address 'Playback 1'
13:26:07 T:35609456 DEBUG: CecLogMessage - device status of Playback 1 changed into 'handled by libCEC'
13:26:07 T:35609456 DEBUG: CecLogMessage - setting ackmask to 10
13:26:07 T:35609456 DEBUG: CecLogMessage - command sent
13:26:07 T:35609456 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:07 T:35609456 DEBUG: CecLogMessage - << Playback 1 (4) -> TV (0): POLL
13:26:07 T:35609456 DEBUG: CecLogMessage - << 40
13:26:07 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:07 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:07 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:07 T:35609456 DEBUG: CecLogMessage - >> POLL sent
13:26:07 T:35609456 DEBUG: CecLogMessage - << requesting vendor ID of 'TV' (0)
13:26:07 T:35609456 DEBUG: CecLogMessage - << 40:8c
13:26:07 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:07 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:07 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:07 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:f ack:high
13:26:07 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 87
13:26:07 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00
13:26:07 T:3067083632 DEBUG: Previous line repeats 1 times.
13:26:07 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 39 eom
13:26:07 T:3058690928 DEBUG: CecLogMessage - >> 0f:87:00:00:39
13:26:07 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): device vendor id (87)
13:26:07 T:3058690928 DEBUG: CecLogMessage - TV (0): vendor = Toshiba (000039)
13:26:07 T:35609456 DEBUG: CecLogMessage - expected response received (87: device vendor id)
13:26:07 T:35609456 DEBUG: CecLogMessage - setting HDMI port to 1 on device TV (0)
13:26:07 T:35609456 DEBUG: CecLogMessage - setting physical address to '1000'
13:26:07 T:35609456 DEBUG: CecLogMessage - marking Playback 1 (4) as inactive source
13:26:07 T:35609456 DEBUG: CecLogMessage - >> Playback 1 (4): power status changed from 'in transition from standby to on' to 'standby'
13:26:07 T:35609456 DEBUG: CecLogMessage - >> Playback 1 (4): physical address changed from ffff to 1000
13:26:07 T:35609456 DEBUG: CecLogMessage - << Playback 1 (4) -> broadcast (F): physical adddress 1000
13:26:07 T:35609456 DEBUG: CecLogMessage - << 4f:84:10:00:04
13:26:07 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:07 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 5 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 4 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:07 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:07 T:35609456 WARNING: CecLogMessage - deprecated method SetActiveView called
13:26:07 T:35609456 DEBUG: CecLogMessage - making Playback 1 (4) the active source
13:26:07 T:35609456 DEBUG: CecLogMessage - >> Playback 1 (4): power status changed from 'standby' to 'on'
13:26:07 T:35609456 DEBUG: CecLogMessage - << 40:04
13:26:07 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:07 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:07 T:2905574256 INFO: Scriptresult: Success
13:26:07 T:2905574256 INFO: Python script stopped
13:26:07 T:2905574256 DEBUG: Thread XBPyThread 2905574256 terminating
13:26:07 T:2947537776 DEBUG: GetZipList - Processing zip://special%3a%2f%2fxbmc%2fmedia%2fweather%2ezip/
13:26:07 T:13420352 DEBUG: waiting for python thread 1 to stop
13:26:07 T:13420352 DEBUG: python thread 1 destructed
13:26:07 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:07 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:07 T:35609456 DEBUG: CecLogMessage - << Playback 1 (4) -> broadcast (F): active source (1000)
13:26:07 T:35609456 DEBUG: CecLogMessage - << 4f:82:10:00
13:26:07 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:07 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 4 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:07 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:08 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:08 T:35609456 DEBUG: CecLogMessage - << Playback 1 (4) -> TV (0): menu state 'activated'
13:26:08 T:35609456 DEBUG: CecLogMessage - << 40:8e:00
13:26:08 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:08 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:08 T:35609456 DEBUG: CecLogMessage - << 40:04
13:26:08 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:08 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:08 T:35609456 DEBUG: CecLogMessage - << Playback 1 (4) -> broadcast (F): active source (1000)
13:26:08 T:35609456 DEBUG: CecLogMessage - << 4f:82:10:00
13:26:08 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 4 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:08 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:08 T:35609456 DEBUG: CecLogMessage - << Playback 1 (4) -> TV (0): menu state 'activated'
13:26:08 T:35609456 DEBUG: CecLogMessage - << 40:8e:00
13:26:08 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:08 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:08 T:35609456 DEBUG: CecLogMessage - processor thread started
13:26:08 T:35609456 DEBUG: OpenConnection - connection to the CEC adapter opened
13:26:08 T:35609456 DEBUG: CecLogMessage - << requesting power status of 'TV' (0)
13:26:08 T:35609456 DEBUG: CecLogMessage - << 40:8f
13:26:08 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:08 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:08 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:08 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00
13:26:08 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 8e
13:26:08 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00 eom
13:26:08 T:3058690928 DEBUG: CecLogMessage - >> 04:00:8e:00
13:26:08 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): feature abort ( 0)
13:26:08 T:3058690928 DEBUG: CecLogMessage - marking opcode 'menu status' as unsupported feature for device 'TV'
13:26:08 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:08 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 90
13:26:08 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00 eom
13:26:08 T:3058690928 DEBUG: CecLogMessage - >> 04:90:00
13:26:08 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): report power status (90)
13:26:08 T:3058690928 DEBUG: CecLogMessage - >> TV (0): power status changed from 'unknown' to 'on'
13:26:08 T:35609456 DEBUG: CecLogMessage - expected response received (90: report power status)
13:26:08 T:35609456 DEBUG: CecLogMessage - 'TV' (0) is already 'on'
13:26:08 T:35609456 DEBUG: CecLogMessage - << 40:04
13:26:08 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:08 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:08 T:35609456 DEBUG: CecLogMessage - << Playback 1 (4) -> broadcast (F): active source (1000)
13:26:08 T:35609456 DEBUG: CecLogMessage - << 4f:82:10:00
13:26:08 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 4 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:08 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:08 T:35609456 DEBUG: CecLogMessage - << Playback 1 (4) -> TV (0): menu state 'activated'
13:26:08 T:35609456 DEBUG: CecLogMessage - << 40:8e:00
13:26:08 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:08 T:35609456 DEBUG: CecLogMessage - command transmitted
13:26:08 T:2905574256 DEBUG: Thread CEC Adapter Update Thread start, auto delete: 0
13:26:08 T:2905574256 DEBUG: CecLogMessage - 'TV' (0) is already 'on'
13:26:08 T:2905574256 DEBUG: CecLogMessage - << 40:04
13:26:08 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:08 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:09 T:2905574256 DEBUG: CecLogMessage - command transmitted
13:26:09 T:2905574256 DEBUG: CecLogMessage - << Playback 1 (4) -> broadcast (F): active source (1000)
13:26:09 T:2905574256 DEBUG: CecLogMessage - << 4f:82:10:00
13:26:09 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:09 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 4 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:09 T:2905574256 DEBUG: CecLogMessage - command transmitted
13:26:09 T:2905574256 DEBUG: CecLogMessage - << Playback 1 (4) -> TV (0): menu state 'activated'
13:26:09 T:2905574256 DEBUG: CecLogMessage - << 40:8e:00
13:26:09 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:09 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:09 T:2905574256 DEBUG: CecLogMessage - command transmitted
13:26:09 T:2905574256 DEBUG: CecLogMessage - << requesting menu language of 'TV' (0)
13:26:09 T:2905574256 DEBUG: CecLogMessage - << 40:91
13:26:09 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:09 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:09 T:2905574256 DEBUG: CecLogMessage - command transmitted
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:8 destination:0 ack:low eom
13:26:09 T:3058690928 DEBUG: CecLogMessage - >> 80
13:26:09 T:3058690928 DEBUG: CecLogMessage - << POLL: Playback 2 (8) -> Playback 2 (8)
13:26:09 T:3058690928 DEBUG: CecLogMessage - device Playback 2 (8) status changed to present after command feature abort
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:09 T:13420352 DEBUG: ------ Window Deinit (Pointer.xml) ------
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA a0
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00
13:26:09 T:3067083632 DEBUG: Previous line repeats 1 times.
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 39
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 02 eom
13:26:09 T:3058690928 DEBUG: CecLogMessage - >> 04:a0:00:00:39:02
13:26:09 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): vendor command with id (A0)
13:26:09 T:3058690928 DEBUG: CecLogMessage - << transmitting abort message
13:26:09 T:3058690928 DEBUG: CecLogMessage - << 40:00:a0:04
13:26:09 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:09 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 4 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:09 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 8e
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00 eom
13:26:09 T:3058690928 DEBUG: CecLogMessage - >> 04:00:8e:00
13:26:09 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): feature abort ( 0)
13:26:09 T:3058690928 DEBUG: CecLogMessage - marking opcode 'menu status' as unsupported feature for device 'TV'
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:8 ack:low
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA a0
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00
13:26:09 T:3067083632 DEBUG: Previous line repeats 1 times.
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 39
13:26:09 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 02 eom
13:26:09 T:3058690928 DEBUG: CecLogMessage - >> 08:a0:00:00:39:02
13:26:09 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 2 (8): vendor command with id (A0)
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:8 destination:0 ack:low
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA a0
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 04 eom
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> 80:00:a0:04
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> Playback 2 (8) -> TV (0): feature abort ( 0)
13:26:10 T:3058690928 DEBUG: CecLogMessage - marking opcode 'vendor command with id' as unsupported feature for device 'Playback 2'
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 8e
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00 eom
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> 04:00:8e:00
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): feature abort ( 0)
13:26:10 T:3058690928 DEBUG: CecLogMessage - marking opcode 'menu status' as unsupported feature for device 'TV'
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 8e
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00 eom
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> 04:00:8e:00
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): feature abort ( 0)
13:26:10 T:3058690928 DEBUG: CecLogMessage - marking opcode 'menu status' as unsupported feature for device 'TV'
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:f ack:high
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 32
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 65
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 6e
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 67 eom
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> 0f:32:65:6e:67
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): set menu language (32)
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> TV (0): menu language set to 'eng'
13:26:10 T:2905574256 DEBUG: CecLogMessage - expected response received (32: set menu language)
13:26:10 T:2905574256 DEBUG: SetMenuLanguage - language set to 'English'
13:26:10 T:2905574256 DEBUG: CecLogMessage - << Playback 1 (4) -> Audio (5): POLL
13:26:10 T:2905574256 DEBUG: CecLogMessage - << 45
13:26:10 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:10 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:10 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:10 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:10 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:10 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:10 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_FAILED_ACK
13:26:10 T:3067083632 DEBUG: CecLogMessage - did not receive ack
13:26:10 T:2905574256 DEBUG: CecLogMessage - command was not acked
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:10 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 46 eom
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> 04:46
13:26:10 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): give osd name (46)
13:26:10 T:3058690928 DEBUG: CecLogMessage - << Playback 1 (4) -> TV (0): OSD name 'CXBMC'
13:26:11 T:2905574256 DEBUG: CecLogMessage - << 45
13:26:11 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:11 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:11 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:11 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:11 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:11 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:11 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_FAILED_ACK
13:26:11 T:3067083632 DEBUG: CecLogMessage - did not receive ack
13:26:11 T:2905574256 DEBUG: CecLogMessage - command was not acked
13:26:11 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:8 ack:low
13:26:11 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 46 eom
13:26:11 T:2905574256 DEBUG: CecLogMessage - >> POLL not sent
13:26:11 T:3058690928 DEBUG: CecLogMessage - << 40:47:43:58:42:4d:43
13:26:11 T:2905574256 DEBUG: CecLogMessage - << Playback 1 (4) -> TV (0): display OSD message 'Connected'
13:26:11 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:11 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:11 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:11 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:11 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 7 more
13:26:11 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 6 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 5 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 4 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:12 T:3058690928 DEBUG: CecLogMessage - command transmitted
13:26:12 T:2905574256 DEBUG: CecLogMessage - << 40:64:00:43:6f:6e:6e:65:63:74:65:64
13:26:12 T:3058690928 DEBUG: CecLogMessage - >> 08:46
13:26:12 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 2 (8): give osd name (46)
13:26:12 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=8 opcode=46
13:26:12 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:12 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 12 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 11 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 10 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 9 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 8 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 7 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 6 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 5 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 4 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:12 T:3067083632 DEBUG: CecLogMessage - TRANSMIT_SUCCEEDED
13:26:12 T:2905574256 DEBUG: CecLogMessage - command transmitted
13:26:12 T:13420352 DEBUG: ------ Window Init (DialogKaiToast.xml) ------
13:26:12 T:13420352 DEBUG: Alloc resources: 0.01ms (0.01 ms skin load)
13:26:12 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:12 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00
13:26:12 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 64
13:26:12 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00 eom
13:26:12 T:3058690928 DEBUG: CecLogMessage - >> 04:00:64:00
13:26:12 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): feature abort ( 0)
13:26:12 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=00
13:26:12 T:3058690928 DEBUG: CecLogMessage - marking opcode 'set osd string' as unsupported feature for device 'TV'
13:26:13 T:13420352 INFO: LIRC Initialize: using: /dev/lircd
13:26:13 T:13420352 DEBUG: Failed to connect to LIRC. Retry in 20s.
13:26:14 T:13420352 DEBUG: SDLKeyboard: scancode: 74, sym: 0112, unicode: 0000, modifier: 0
13:26:14 T:13420352 DEBUG: OnKey: down (f081) pressed, action is Down
13:26:17 T:13420352 DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
13:26:17 T:13420352 INFO: Python, unloading python shared library because no scripts are running anymore
13:26:17 T:13420352 DEBUG: UnloadExtensionLibs, clearing python extension libraries
13:26:18 T:3067083632 DEBUG: CecLogMessage - sending ping
13:26:18 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:18 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:21 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:21 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 44
13:26:21 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 02 eom
13:26:21 T:3058690928 DEBUG: CecLogMessage - >> 04:44:02
13:26:21 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control pressed (44)
13:26:21 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=44
13:26:21 T:3058690928 DEBUG: CecLogMessage - key pressed: 2
13:26:21 T:13420352 DEBUG: GetNextKey - received key 2
13:26:21 T:13420352 DEBUG: OnKey: 167 (a7) pressed, action is Down
13:26:21 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:21 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 45 eom
13:26:21 T:3058690928 DEBUG: CecLogMessage - >> 04:45
13:26:21 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control release (45)
13:26:21 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=45
13:26:21 T:3058690928 DEBUG: CecLogMessage - key released: 2
13:26:22 T:13420352 DEBUG: GetNextKey - received key 2
13:26:22 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low eom
13:26:22 T:3058690928 DEBUG: CecLogMessage - >> 04
13:26:22 T:3058690928 DEBUG: CecLogMessage - << POLL: TV (0) -> TV (0)
13:26:22 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:8 ack:low eom
13:26:22 T:3058690928 DEBUG: CecLogMessage - >> 08
13:26:22 T:3058690928 DEBUG: CecLogMessage - << POLL: TV (0) -> TV (0)
13:26:22 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:22 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 44
13:26:22 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 02 eom
13:26:22 T:3058690928 DEBUG: CecLogMessage - >> 04:44:02
13:26:22 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control pressed (44)
13:26:22 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=44
13:26:22 T:3058690928 DEBUG: CecLogMessage - key pressed: 2
13:26:22 T:13420352 DEBUG: GetNextKey - received key 2
13:26:22 T:13420352 DEBUG: OnKey: 167 (a7) pressed, action is Down
13:26:22 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:22 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 45 eom
13:26:22 T:3058690928 DEBUG: CecLogMessage - >> 04:45
13:26:22 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control release (45)
13:26:22 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=45
13:26:22 T:3058690928 DEBUG: CecLogMessage - key released: 2
13:26:22 T:13420352 DEBUG: GetNextKey - received key 2
13:26:23 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:23 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 44
13:26:23 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00 eom
13:26:23 T:3058690928 DEBUG: CecLogMessage - >> 04:44:00
13:26:23 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control pressed (44)
13:26:23 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=44
13:26:23 T:3058690928 DEBUG: CecLogMessage - key pressed: 0
13:26:23 T:13420352 DEBUG: GetNextKey - received key 0
13:26:23 T:13420352 DEBUG: OnKey: 11 (0b) pressed, action is Select
13:26:23 T:13420352 DEBUG: ExecuteXBMCAction : Translating ActivateWindow(ShutdownMenu)
13:26:23 T:13420352 DEBUG: ExecuteXBMCAction : To ActivateWindow(ShutdownMenu)
13:26:23 T:13420352 DEBUG: Activating window ID: 10111
13:26:23 T:13420352 DEBUG: ------ Window Init (DialogButtonMenu.xml) ------
13:26:23 T:13420352 INFO: Loading skin file: DialogButtonMenu.xml
13:26:23 T:13420352 DEBUG: Load DialogButtonMenu.xml: 11.57ms
13:26:23 T:13420352 DEBUG: Alloc resources: 12.78ms (11.82 ms skin load)
13:26:23 T:13420352 DEBUG: ExecuteXBMCAction : Translating down
13:26:23 T:13420352 DEBUG: ExecuteXBMCAction : To down
13:26:23 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:23 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 45 eom
13:26:23 T:3058690928 DEBUG: CecLogMessage - >> 04:45
13:26:23 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control release (45)
13:26:23 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=45
13:26:23 T:3058690928 DEBUG: CecLogMessage - key released: 0
13:26:23 T:13420352 DEBUG: GetNextKey - received key 0
13:26:24 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:24 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 44
13:26:24 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 02 eom
13:26:24 T:3058690928 DEBUG: CecLogMessage - >> 04:44:02
13:26:24 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control pressed (44)
13:26:24 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=44
13:26:24 T:3058690928 DEBUG: CecLogMessage - key pressed: 2
13:26:24 T:13420352 DEBUG: GetNextKey - received key 2
13:26:24 T:13420352 DEBUG: OnKey: 167 (a7) pressed, action is Down
13:26:24 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:24 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 45 eom
13:26:24 T:3058690928 DEBUG: CecLogMessage - >> 04:45
13:26:24 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control release (45)
13:26:24 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=45
13:26:24 T:3058690928 DEBUG: CecLogMessage - key released: 2
13:26:24 T:13420352 DEBUG: GetNextKey - received key 2
13:26:25 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:25 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 44
13:26:25 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 02 eom
13:26:25 T:3058690928 DEBUG: CecLogMessage - >> 04:44:02
13:26:25 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control pressed (44)
13:26:25 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=44
13:26:25 T:3058690928 DEBUG: CecLogMessage - key pressed: 2
13:26:25 T:13420352 DEBUG: GetNextKey - received key 2
13:26:25 T:13420352 DEBUG: OnKey: 167 (a7) pressed, action is Down
13:26:25 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:25 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 45 eom
13:26:25 T:3058690928 DEBUG: CecLogMessage - >> 04:45
13:26:25 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control release (45)
13:26:25 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=45
13:26:25 T:3058690928 DEBUG: CecLogMessage - key released: 2
13:26:25 T:13420352 DEBUG: GetNextKey - received key 2
13:26:26 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:26 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 44
13:26:26 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 02 eom
13:26:26 T:3058690928 DEBUG: CecLogMessage - >> 04:44:02
13:26:26 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control pressed (44)
13:26:26 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=44
13:26:26 T:3058690928 DEBUG: CecLogMessage - key pressed: 2
13:26:26 T:13420352 DEBUG: GetNextKey - received key 2
13:26:26 T:13420352 DEBUG: OnKey: 167 (a7) pressed, action is Down
13:26:26 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:26 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 45 eom
13:26:26 T:3058690928 DEBUG: CecLogMessage - >> 04:45
13:26:26 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control release (45)
13:26:26 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=45
13:26:26 T:3058690928 DEBUG: CecLogMessage - key released: 2
13:26:26 T:13420352 DEBUG: GetNextKey - received key 2
13:26:32 T:3067083632 DEBUG: CecLogMessage - FRAME_START initiator:0 destination:4 ack:low
13:26:32 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 44
13:26:32 T:3067083632 DEBUG: CecLogMessage - FRAME_DATA 00 eom
13:26:32 T:3058690928 DEBUG: CecLogMessage - >> 04:44:00
13:26:32 T:3058690928 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): user control pressed (44)
13:26:32 T:3058690928 DEBUG: CecCommand - processing command: initiator=0 destination=4 opcode=44
13:26:32 T:3058690928 DEBUG: CecLogMessage - key pressed: 0
13:26:32 T:13420352 DEBUG: GetNextKey - received key 0
13:26:32 T:13420352 DEBUG: OnKey: 11 (0b) pressed, action is Select
13:26:32 T:13420352 DEBUG: ExecuteXBMCAction : Translating XBMC.Suspend()
13:26:32 T:13420352 DEBUG: ExecuteXBMCAction : To XBMC.Suspend()
13:26:32 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UPower on /org/freedesktop/UPower with interface org.freedesktop.UPower and method AboutToSleep
13:26:32 T:13420352 DEBUG: DBus: Creating message to org.freedesktop.UPower on /org/freedesktop/UPower with interface org.freedesktop.UPower and method Suspend
13:26:32 T:13420352 DEBUG: ------ Window Deinit (DialogButtonMenu.xml) ------
13:26:32 T:13420352 DEBUG: CAnnouncementManager - Announcement: OnSleep from xbmc
13:26:32 T:13420352 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnSleep
13:26:32 T:2905574256 DEBUG: CecLogMessage - SetConfiguration - using physical address ' 0'
13:26:32 T:2905574256 DEBUG: CecLogMessage - SetConfiguration - using base device '0'
13:26:32 T:2905574256 DEBUG: CecLogMessage - SetConfiguration - using HDMI port '1'
13:26:32 T:2905574256 DEBUG: CecLogMessage - >> Playback 1 (4): osd name set to 'XBMC'
13:26:32 T:2905574256 DEBUG: CecLogMessage - << Playback 1 (4) -> TV (0): OSD name 'XBMC'
13:26:32 T:2905574256 DEBUG: CecLogMessage - << 40:47:58:42:4d:43
13:26:32 T:3067083632 DEBUG: CecLogMessage - setting the line timeout to 3
13:26:32 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:32 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 0 more
13:26:32 T:3067083632 DEBUG: CecLogMessage - command sent
13:26:32 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 6 more
13:26:32 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 5 more
13:26:32 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 4 more
13:26:32 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 3 more
13:26:32 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 2 more
13:26:32 T:3067083632 DEBUG: CecLogMessage - COMMAND_ACCEPTED - waiting for 1 more
13:26:32 T:2893491056 DEBUG: CecLogMessage - key released: 0
13:26:34 T:2955930480 DEBUG: Thread Jobworker 2955930480 terminating (autodelete)
13:26:34 T:3037723504 DEBUG: Thread Jobworker 3037723504 terminating (autodelete)
13:26:34 T:2913966960 DEBUG: Thread Jobworker 2913966960 terminating (autodelete)
13:27:29 T:2947537776 DEBUG: Thread Jobworker 2947537776 terminating (autodelete)