Kodi Community Forum

Full Version: MythTV PVR client 1.9.15 is not connecting to mythbackend ( version 0.27 )
You're currently viewing a stripped down version of our content. View the full version with proper formatting.
Hello all.
Was fiddling with XBMC-MythTV PVR setup for quite a long time and also was reading this forum; unfortunately did not found any clu how to fix the problem.

I have beta latest XBMC and MythTV PVR add-onersion version 1.9.15 ( supports MythTV up to 0.27 ) .

MythTV Version : v0.27-1-g5b917e8
MythTV Branch : fixes/0.27
Network Protocol : 77
Library API : 0.27.20130902-1
QT Version : 4.8.4


Below is attached log from XBMC debug on Any insight, tip, troubleshooting direction will be really appreciated. I will provide any additional logs and/or TCPDUMP captures if nessesary.[/code]

Code:
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_connect_event: connecting event channel connection
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_connect_addr: setting socket option SO_RCVBUF to 128000
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_connect_addr: connecting to 192.168.0.202:6543 fd = 1348
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_create {
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_create }
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_send_message
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_send_message: sending message '20      MYTH_PROTO_VERSION 8'
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_length
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_length: buffer is '13      ' ret = 13
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_string: string received 'REJECT'
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_string: string received '77'
16:40:02 T:4584   ERROR: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_connect: asked for version 8, got version 77
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_destroy {
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_destroy: shutdown and close connection fd = 1348
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_destroy }
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_connect_addr: setting socket option SO_RCVBUF to 128000
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_connect_addr: connecting to 192.168.0.202:6543 fd = 1348
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_create {
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_create }
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_send_message
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_send_message: sending message '30      MYTH_PROTO_VERSION 77 WindMark'
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_length
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_length: buffer is '13      ' ret = 13
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_string: string received 'ACCEPT'
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_string: string received '77'
16:40:02 T:4584   ERROR: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_connect: asked for version 77, got version 77
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_connect: agreed on Version 77 protocol
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_send_message
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_send_message: sending message '25      ANN Monitor geshka-XBMC 1'
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_length
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_length: buffer is '94      ' ret = 94
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_string: string received 'BAC    '
16:40:02 T:4584    INFO: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_okay: did not consume everything
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_data: data received 'SYSTEM_EVENT CLIENT_CONNECTED HOSTNAME geshka-XBMC SENDER mythTV[]:[]empty'
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_rcv_okay: leftover data: count 74, read 74, errno 0
16:40:02 T:4584   ERROR: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_connect: cmyth_rcv_okay() failed
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_destroy {
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_destroy: shutdown and close connection fd = 1348
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_destroy }
16:40:02 T:4584   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_connect_event: done connecting event channel connection ret = 00000000
16:40:02 T:4584  NOTICE: AddOnLog: MythTV cmyth PVR Client: MythEventHandler::MythEventHandlerPrivate::RetryConnect - Could not connect client to event socket
16:40:02 T:4196   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_database_destroy
16:40:02 T:4196   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_destroy {
16:40:02 T:4196   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_send_message
16:40:02 T:4196   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)__cmyth_send_message: sending message '4       DONE'
16:40:02 T:4196   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_destroy: shutdown and close connection fd = 1304
16:40:02 T:4196   DEBUG: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_conn_destroy }
16:40:02 T:4196   DEBUG: Calling TransferSettings for: MythTV cmyth PVR Client
16:40:02 T:4196   ERROR: PVR - couldn't get the capabilities for add-on 'unknown'. Please contact the developer of this add-on: Christian Fetzer, Jean-Luc Barrière, Tonny Petersen
16:40:03 T:4196   DEBUG: PVR::CPVRClients::RegisterClient - registering add-on 'MythTV cmyth PVR Client'
16:40:03 T:4468  NOTICE: Thread LanguageInvoker start, auto delete: false
16:40:03 T:4468    INFO: initializing python engine.
16:40:03 T:4468   DEBUG: CPythonInvoker(1, C:\Users\geshka\AppData\Roaming\XBMC\addons\service.xbmc.versioncheck\service.py): start processing
16:40:03 T:4468  NOTICE: -->Python Interpreter Initialized<--
16:40:03 T:4468   DEBUG: CPythonInvoker(1, C:\Users\geshka\AppData\Roaming\XBMC\addons\service.xbmc.versioncheck\service.py): the source file to load is C:\Users\geshka\AppData\Roaming\XBMC\addons\service.xbmc.versioncheck\service.py
16:40:03 T:4468   DEBUG: CPythonInvoker(1, C:\Users\geshka\AppData\Roaming\XBMC\addons\service.xbmc.versioncheck\service.py): setting the Python path to C:\Users\geshka\AppData\Roaming\XBMC\addons\service.xbmc.versioncheck;C:\Program Files (x86)\XBMC\addons\script.module.pil\lib;C:\Program Files (x86)\XBMC\addons\xbmc.debug\;C:\Program Files (x86)\XBMC\system\python\DLLs;C:\Program Files (x86)\XBMC\system\python\Lib;C:\Program Files (x86)\XBMC\python27.zip;C:\Program Files (x86)\XBMC\system\python\lib\plat-win;C:\Program Files (x86)\XBMC\system\python\lib\lib-tk;C:\Program Files (x86)\XBMC;C:\Program Files (x86)\XBMC\system\python;C:\Program Files (x86)\XBMC\system\python\lib\site-packages
16:40:03 T:4468   DEBUG: CPythonInvoker(1, C:\Users\geshka\AppData\Roaming\XBMC\addons\service.xbmc.versioncheck\service.py): entering source directory C:\Users\geshka\AppData\Roaming\XBMC\addons\service.xbmc.versioncheck
16:40:03 T:4468   DEBUG: CPythonInvoker(1, C:\Users\geshka\AppData\Roaming\XBMC\addons\service.xbmc.versioncheck\service.py): instantiating addon using automatically obtained id of "service.xbmc.versioncheck" dependent on version 2.1.0 of the xbmc.python api
16:40:03 T:4468   DEBUG: XBMC Version Check: Version 0.1.19 started
16:40:03 T:4468   DEBUG: XBMC Version Check: Version installed {u'major': 13, u'tag': u'beta', u'minor': 0, u'revision': u'20140315-a1cab7a'}
16:40:03 T:4468   DEBUG: XBMC Version Check: Nothing to see here, move along. Running a latest non stable release
16:40:03 T:4468    INFO: CPythonInvoker(1, C:\Users\geshka\AppData\Roaming\XBMC\addons\service.xbmc.versioncheck\service.py): script successfully run
16:40:03 T:4468    INFO: Python script stopped
16:40:03 T:4468   DEBUG: Thread LanguageInvoker 4468 terminating
16:40:03 T:2504   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/players/dvdplayer/swresample-0.dll)
16:40:04 T:4196   DEBUG: PVR::CPVRClients::RegisterClient - registering add-on 'MythTV cmyth PVR Client'
16:40:04 T:2504    INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://feeds.xbmc.org (easy=0329C818, multi=00097FD0)
16:40:04 T:2504   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
16:40:04 T:2504   DEBUG: CGUIMediaWindow::GetDirectory (addons://disabled/xbmc.pvrclient)
16:40:04 T:2504   DEBUG:   ParentPath = [addons://disabled/xbmc.pvrclient]
16:40:04 T:2552  NOTICE: Thread BackgroundLoader start, auto delete: false
16:40:04 T:2504   DEBUG: ------ Window Init (Pointer.xml) ------
16:40:04 T:3408   DEBUG: CTextureCacheJob::GetImageHash - unable to stat url C:\Program Files (x86)\XBMC\addons\pvr.demo\icon.png
16:40:04 T:2552   DEBUG: Thread BackgroundLoader 2552 terminating
16:40:05 T:2504   DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
16:40:07 T:2504   DEBUG: Keyboard: scancode: 0x38, sym: 0x0134, unicode: 0x0000, modifier: 0x100
16:40:07 T:2504   DEBUG: CApplication::OnKey: alt-leftalt (0x4f0d4) pressed, action is
16:40:07 T:2504   DEBUG: ------ Window Deinit (Pointer.xml) ------
16:40:07 T:2504   DEBUG: CWinEventsWin32::WndProcWindow is inactive
16:40:13 T:2504    INFO: Python, unloading python shared library because no scripts are running anymore
Is mythtv (including the mysql database) properly set up to accept connections from your LAN? A common error is to set it up to only work on localhost.
Yes, It is seems to be so. It is working with other mythfrontend located on separate laptop, so I think it is able to receive external connections.
Then I suggest you post a debug log (wiki) to pastebin and post the link here (no more posting your logs inline please).
It is quite interesting outcome from my today's troubleshooting effort - when laptop starts on WiFi - Myth addon connecting OK, but when boot up process finished with wired connection - addon is unable to connect to backend.... after boot I can plug Eth cable and it works also fine.

Any thoughts ?

Second issue that I have now is live TV is heavily choppy and pixelated. What could be possible reason for that?
I suggest you post a debug log to pastebin and post the link here (no more posting your logs inline please).
Thanks for the prompt response. Here we go...

This one with Eth cable attached
http://pastebin.com/Swxw3aRd

This one with Wifi only.
http://pastebin.com/HFsgiuqs
Quote:15:41:43 T:5036 ERROR: AddOnLog: MythTV cmyth PVR Client: LibCMyth: (cmyth)cmyth_mysql_testdb_connection: mysql_connect() failed: Host '192.168.0.125' is blocked because of many connection errors; unblock with 'mysqladmin flush-hosts'
Try running the suggested mysqladmin command on the backend. You will probably need to use sudo to do so.