[mythtv-users] 29 upgrade issue?

Udo van den Heuvel udovdh at xs4all.nl
Thu May 17 14:09:06 UTC 2018


Hello,

We upgraded from 28.1.whatever (fixes) to 29.
We ran mythtv-setup.
The database changes were OK, upon starting the backend we got this log:

$ cat mythbackend.20180517140310.21559.log
2018-05-17 16:03:10.937061 C [21559/21559] thread_unknown
mythcommandlineparser.cpp:2619 (ConfigureLogging) - mythbackend version:
master [v29.1-v29.1-19-g0849e99596] www.mythtv.org
2018-05-17 16:03:10.937229 C [21559/21559] thread_unknown
mythcommandlineparser.cpp:2621 (ConfigureLogging) - Qt version: compile:
5.10.1, runtime: 5.10.1
2018-05-17 16:03:10.937237 N [21559/21559] thread_unknown
mythcommandlineparser.cpp:2623 (ConfigureLogging) - Enabled verbose
msgs:  general
2018-05-17 16:03:10.937773 N [21559/21559] thread_unknown
logging.cpp:927 (logStart) - Setting Log Level to LOG_INFO
2018-05-17 16:03:10.950629 I [21559/21562] Logger logging.cpp:313 (run)
- Added logging to the console
2018-05-17 16:03:10.951929 I [21559/21559] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Interrupt handler
2018-05-17 16:03:10.951955 I [21559/21559] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Terminated handler
2018-05-17 16:03:10.951970 I [21559/21559] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Segmentation fault
handler
2018-05-17 16:03:10.951988 I [21559/21559] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Aborted handler
2018-05-17 16:03:10.952000 I [21559/21559] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Bus error handler
2018-05-17 16:03:10.952017 I [21559/21559] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Floating point
exception handler
2018-05-17 16:03:10.952030 I [21559/21559] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Illegal instruction
handler
2018-05-17 16:03:10.952067 I [21559/21559] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Real-time signal 0
handler
2018-05-17 16:03:10.952085 I [21559/21559] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Hangup handler
2018-05-17 16:03:10.952521 N [21559/21559] thread_unknown
mythdirs.cpp:195 (InitializeMythDirs) - Using runtime prefix = /usr
2018-05-17 16:03:10.952528 N [21559/21559] thread_unknown
mythdirs.cpp:197 (InitializeMythDirs) - Using configuration directory =
/home/mythtv/.mythtv
2018-05-17 16:03:10.952739 I [21559/21559] CoreContext
mythcorecontext.cpp:271 (Init) - Assumed character encoding: en_US.UTF-8
2018-05-17 16:03:10.953866 I [21559/21559] CoreContext
mythcontext.cpp:607 (LoadDatabaseSettings) - Using localhost value of
localhost
2018-05-17 16:03:10.954041 I [21559/21559] CoreContext
mythcontext.cpp:852 (TestDBconnection) - Start up testing connections.
DB localhost, BE , attempt 0, status dbAwake
2018-05-17 16:03:11.065370 I [21559/21561] LogForward
loggingserver.cpp:146 (FileLogger) - Added logging to
/var/log/mythtv/mythbackend.20180517140310.21559.log
2018-05-17 16:03:11.994622 N [21559/21559] CoreContext
mythcorecontext.cpp:1768 (InitLocale) - Setting QT default locale to EN_US
2018-05-17 16:03:11.994649 I [21559/21559] CoreContext
mythcorecontext.cpp:1801 (SaveLocaleDefaults) - Current locale EN_US
2018-05-17 16:03:11.994741 N [21559/21559] CoreContext
mythlocale.cpp:123 (LoadDefaultsFromXML) - Reading locale defaults from
/usr/share/mythtv//locales/en_us.xml
2018-05-17 16:03:12.005356 I [21559/21559] CoreContext
mythtranslation.cpp:73 (load) - Loading en_us translation for module
mythfrontend
2018-05-17 16:03:12.010654 I [21559/21559] CoreContext
schemawizard.cpp:120 (Compare) - Current MythTV Schema Version
(DBSchemaVer): 1348
2018-05-17 16:03:12.011132 I [21559/21559] CoreContext
mythtranslation.cpp:73 (load) - Loading en_us translation for module
mythfrontend
2018-05-17 16:03:12.014087 E [21559/21564] MythSocketThread(-1)
mythsocket.cpp:698 (ConnectToHostReal) - MythSocket(8d9d20:-1): Failed
to connect to (127.0.0.1:6543) Connection refused
2018-05-17 16:03:12.015883 N [21559/21559] CoreContext
main_helpers.cpp:601 (run_backend) - MythBackend: Running as a slave
backend.
2018-05-17 16:03:12.891994 I [21559/21559] CoreContext
housekeeper.cpp:633 (RegisterTask) - Registering HouseKeeperTask
'JobQueueRecover'.
2018-05-17 16:03:12.892043 I [21559/21559] CoreContext
housekeeper.cpp:633 (RegisterTask) - Registering HouseKeeperTask
'HardwareProfiler'.
2018-05-17 16:03:12.894256 I [21559/21559] CoreContext
housekeeper.cpp:706 (Start) - Starting HouseKeeper.
2018-05-17 16:03:13.014815 I [21559/21559] CoreContext
serverpool.cpp:422 (listen) - Listening on TCP 0.0.0.0:6544
2018-05-17 16:03:13.172876 E [21559/21559] CoreContext
serverpool.cpp:435 (listen) - Failed listening on TCP [::]:6544 - Error
10: Protocol type not supported
2018-05-17 16:03:13.172953 I [21559/21559] CoreContext
serverpool.cpp:460 (listen) - IPv6 support failed for this port.
2018-05-17 16:03:13.173075 I [21559/21559] CoreContext
serverpool.cpp:422 (listen) - Listening on TCP 0.0.0.0:6554
2018-05-17 16:03:13.176198 E [21559/21559] CoreContext
serverpool.cpp:435 (listen) - Failed listening on TCP [::]:6554 - Error
10: Protocol type not supported
2018-05-17 16:03:13.176229 I [21559/21559] CoreContext
serverpool.cpp:460 (listen) - IPv6 support failed for this port.
2018-05-17 16:03:13.176453 I [21559/21559] CoreContext
serverpool.cpp:422 (listen) - Listening on TCP 0.0.0.0:6549
2018-05-17 16:03:13.179334 E [21559/21559] CoreContext
serverpool.cpp:435 (listen) - Failed listening on TCP [::]:6549 - Error
10: Protocol type not supported
2018-05-17 16:03:13.179361 I [21559/21559] CoreContext
serverpool.cpp:460 (listen) - IPv6 support failed for this port.
2018-05-17 16:03:13.824524 I [21559/21559] CoreContext
main_helpers.cpp:687 (run_backend) - Main::Registering HttpStatus Extension
2018-05-17 16:03:13.827687 I [21559/21559] CoreContext
serverpool.cpp:422 (listen) - Listening on TCP 0.0.0.0:6543
2018-05-17 16:03:13.831182 E [21559/21559] CoreContext
serverpool.cpp:435 (listen) - Failed listening on TCP [::]:6543 - Error
10: Protocol type not supported
2018-05-17 16:03:13.831202 I [21559/21559] CoreContext
serverpool.cpp:460 (listen) - IPv6 support failed for this port.
2018-05-17 16:03:14.611546 I [21559/21559] CoreContext
bonjourregister.cpp:118 (BonjourCallback) - Bonjour: Service
registration complete: name 'Mythbackend on localhost' type
'_mythbackend._tcp.' domain: 'local.'
2018-05-17 16:03:14.781293 N [21559/21559] CoreContext
mainserver.cpp:7991 (reconnectTimeout) - MainServer: Connecting to
master server: 127.0.0.1:6543
2018-05-17 16:03:14.782041 N [21559/21559] CoreContext
mainserver.cpp:8002 (reconnectTimeout) - MainServer: Connected successfully
2018-05-17 16:03:44.797883 E [21559/21586] MythSocketThread(-1)
mythsocket.cpp:827 (ReadStringListReal) - MythSocket(9419c0:46):
ReadStringList: Error, timed out after 30000 ms.
2018-05-17 16:03:44.798144 W [21559/21586] MythSocketThread(-1)
mainserver.cpp:7704 (connectionClosed) - MainServer: Unknown socket
closing MythSocket(0x9419c0)
2018-05-17 16:03:44.798288 E [21559/21559] CoreContext
mythsocket.cpp:369 (SendReceiveStringList) - MythSocket(9419c0:-1): No
response.
2018-05-17 16:03:44.798312 E [21559/21559] CoreContext
mainserver.cpp:8040 (reconnectTimeout) - MainServer: Failed to open
master server socket, timeout
2018-05-17 16:03:44.804352 I [21559/21602] MythSocketThread(8)
mainserver.cpp:7693 (connectionClosed) - Control sock(947e80) disconnected
2018-05-17 16:03:45.763221 N [21559/21559] CoreContext
mainserver.cpp:7991 (reconnectTimeout) - MainServer: Connecting to
master server: 127.0.0.1:6543
2018-05-17 16:03:45.763821 N [21559/21559] CoreContext
mainserver.cpp:8002 (reconnectTimeout) - MainServer: Connected successfully
2018-05-17 16:04:15.780109 E [21559/21604] MythSocketThread(-1)
mythsocket.cpp:827 (ReadStringListReal) - MythSocket(93cfb0:47):
ReadStringList: Error, timed out after 30000 ms.
2018-05-17 16:04:15.780243 W [21559/21604] MythSocketThread(-1)
mainserver.cpp:7704 (connectionClosed) - MainServer: Unknown socket
closing MythSocket(0x93cfb0)
2018-05-17 16:04:15.780381 E [21559/21559] CoreContext
mythsocket.cpp:369 (SendReceiveStringList) - MythSocket(93cfb0:-1): No
response.
2018-05-17 16:04:15.780405 E [21559/21559] CoreContext
mainserver.cpp:8040 (reconnectTimeout) - MainServer: Failed to open
master server socket, timeout
2018-05-17 16:04:15.781274 I [21559/21613] MythSocketThread(47)
mainserver.cpp:7693 (connectionClosed) - Control sock(958d00) disconnected
2018-05-17 16:04:16.763329 N [21559/21559] CoreContext
mainserver.cpp:7991 (reconnectTimeout) - MainServer: Connecting to
master server: 127.0.0.1:6543
2018-05-17 16:04:16.763920 N [21559/21559] CoreContext
mainserver.cpp:8002 (reconnectTimeout) - MainServer: Connected successfully
2018-05-17 16:04:46.785086 E [21559/21614] MythSocketThread(-1)
mythsocket.cpp:827 (ReadStringListReal) - MythSocket(93d5a0:49):
ReadStringList: Error, timed out after 30000 ms.
2018-05-17 16:04:46.785223 W [21559/21614] MythSocketThread(-1)
mainserver.cpp:7704 (connectionClosed) - MainServer: Unknown socket
closing MythSocket(0x93d5a0)
2018-05-17 16:04:46.785359 E [21559/21559] CoreContext
mythsocket.cpp:369 (SendReceiveStringList) - MythSocket(93d5a0:-1): No
response.
2018-05-17 16:04:46.785382 E [21559/21559] CoreContext
mainserver.cpp:8040 (reconnectTimeout) - MainServer: Failed to open
master server socket, timeout
2018-05-17 16:04:46.787171 I [21559/21616] MythSocketThread(49)
mainserver.cpp:7693 (connectionClosed) - Control sock(94a620) disconnected
2018-05-17 16:04:47.763195 N [21559/21559] CoreContext
mainserver.cpp:7991 (reconnectTimeout) - MainServer: Connecting to
master server: 127.0.0.1:6543
2018-05-17 16:04:47.763807 N [21559/21559] CoreContext
mainserver.cpp:8002 (reconnectTimeout) - MainServer: Connected successfully
2018-05-17 16:05:17.784224 E [21559/21617] MythSocketThread(-1)
mythsocket.cpp:827 (ReadStringListReal) - MythSocket(93c590:51):
ReadStringList: Error, timed out after 30000 ms.
2018-05-17 16:05:17.784359 W [21559/21617] MythSocketThread(-1)
mainserver.cpp:7704 (connectionClosed) - MainServer: Unknown socket
closing MythSocket(0x93c590)
2018-05-17 16:05:17.784497 E [21559/21559] CoreContext
mythsocket.cpp:369 (SendReceiveStringList) - MythSocket(93c590:-1): No
response.
2018-05-17 16:05:17.784518 E [21559/21559] CoreContext
mainserver.cpp:8040 (reconnectTimeout) - MainServer: Failed to open
master server socket, timeout
2018-05-17 16:05:17.785389 I [21559/21618] MythSocketThread(51)
mainserver.cpp:7693 (connectionClosed) - Control sock(94b3d0) disconnected
2018-05-17 16:05:18.763358 N [21559/21559] CoreContext
mainserver.cpp:7991 (reconnectTimeout) - MainServer: Connecting to
master server: 127.0.0.1:6543
2018-05-17 16:05:18.763961 N [21559/21559] CoreContext
mainserver.cpp:8002 (reconnectTimeout) - MainServer: Connected successfully
2018-05-17 16:05:48.781072 E [21559/21619] MythSocketThread(-1)
mythsocket.cpp:827 (ReadStringListReal) - MythSocket(94be10:53):
ReadStringList: Error, timed out after 30000 ms.
2018-05-17 16:05:48.781207 W [21559/21619] MythSocketThread(-1)
mainserver.cpp:7704 (connectionClosed) - MainServer: Unknown socket
closing MythSocket(0x94be10)
2018-05-17 16:05:48.781342 E [21559/21559] CoreContext
mythsocket.cpp:369 (SendReceiveStringList) - MythSocket(94be10:-1): No
response.
2018-05-17 16:05:48.781366 E [21559/21559] CoreContext
mainserver.cpp:8040 (reconnectTimeout) - MainServer: Failed to open
master server socket, timeout
2018-05-17 16:05:48.782288 I [21559/21621] MythSocketThread(53)
mainserver.cpp:7693 (connectionClosed) - Control sock(ac3370) disconnected
2018-05-17 16:05:49.763234 N [21559/21559] CoreContext
mainserver.cpp:7991 (reconnectTimeout) - MainServer: Connecting to
master server: 127.0.0.1:6543
2018-05-17 16:05:49.763822 N [21559/21559] CoreContext
mainserver.cpp:8002 (reconnectTimeout) - MainServer: Connected successfully
2018-05-17 16:05:58.870448 I [21559/21568] TVRecEvent tv_rec.cpp:3657
(TuningFrequency) - TVRec[1]: TuningFrequency
2018-05-17 16:06:19.772226 E [21559/21622] MythSocketThread(-1)
mythsocket.cpp:827 (ReadStringListReal) - MythSocket(ac34e0:55):
ReadStringList: Error, timed out after 30000 ms.
2018-05-17 16:06:19.772368 W [21559/21622] MythSocketThread(-1)
mainserver.cpp:7704 (connectionClosed) - MainServer: Unknown socket
closing MythSocket(0xac34e0)
2018-05-17 16:06:19.772504 E [21559/21559] CoreContext
mythsocket.cpp:369 (SendReceiveStringList) - MythSocket(ac34e0:-1): No
response.
2018-05-17 16:06:19.772525 E [21559/21559] CoreContext
mainserver.cpp:8040 (reconnectTimeout) - MainServer: Failed to open
master server socket, timeout
2018-05-17 16:06:19.773427 I [21559/21626] MythSocketThread(55)
mainserver.cpp:7693 (connectionClosed) - Control sock(94e370) disconnected
2018-05-17 16:06:20.763366 N [21559/21559] CoreContext
mainserver.cpp:7991 (reconnectTimeout) - MainServer: Connecting to
master server: 127.0.0.1:6543
2018-05-17 16:06:20.763920 N [21559/21559] CoreContext
mainserver.cpp:8002 (reconnectTimeout) - MainServer: Connected successfully
2018-05-17 16:06:50.771202 E [21559/21627] MythSocketThread(-1)
mythsocket.cpp:827 (ReadStringListReal) - MythSocket(94e5f0:76):
ReadStringList: Error, timed out after 30000 ms.
2018-05-17 16:06:50.771335 W [21559/21627] MythSocketThread(-1)
mainserver.cpp:7704 (connectionClosed) - MainServer: Unknown socket
closing MythSocket(0x94e5f0)
2018-05-17 16:06:50.771450 E [21559/21559] CoreContext
mythsocket.cpp:369 (SendReceiveStringList) - MythSocket(94e5f0:-1): No
response.
2018-05-17 16:06:50.771474 E [21559/21559] CoreContext
mainserver.cpp:8040 (reconnectTimeout) - MainServer: Failed to open
master server socket, timeout
2018-05-17 16:06:50.772307 I [21559/21633] MythSocketThread(76)
mainserver.cpp:7693 (connectionClosed) - Control sock(ac8cd0) disconnected


What is happening here?
What is wrong?
What is that?
How can we fix this?

Kind regards,
Udo


More information about the mythtv-users mailing list