[mythtv-users] Web Frontend stopped working yesterday

Janusz S. Bień jsbien at mimuw.edu.pl
Fri Jul 19 07:31:35 UTC 2019 

On Fri, Jul 19 2019 at  1:10 -05, Bill Meek wrote:
> On 7/19/19 12:45 AM, Janusz S. Bień wrote:
>> On Fri, Jul 12 2019 at  7:24 +02, Janusz S. Bień wrote:

[...]

>> I looked at all available log options and I don't see anything relevant
>> for the internal web server, which is definitely the culprit.
>>
>> Any suggestions?

Thank you very much for your quick reaction.

>
> mythbackend --setverbose http:debug,upnp:debug
>
> will produce lots log lines for WebFrontend, you might even leave off the ,upnp:debug
> for starters.

Using this when the backend is running doesn't seem sufficient:

--8<---------------cut here---------------start------------->8---
mythbackend --setverbose http:debug,upnp:debug
2019-07-19 09:09:45.824881 C  mythbackend version: fixes/30 [v30.0-4fd4d574c6d] www.mythtv.org
2019-07-19 09:09:45.824899 C  Qt version: compile: 5.11.3, runtime: 5.11.3
2019-07-19 09:09:45.824903 N  Enabled verbose msgs:  general
2019-07-19 09:09:45.824912 N  Setting Log Level to LOG_INFO
2019-07-19 09:09:45.835591 I  Added logging to the console
2019-07-19 09:09:45.836200 I  Setup Interrupt handler
2019-07-19 09:09:45.836220 I  Setup Terminated handler
2019-07-19 09:09:45.836241 I  Setup Segmentation fault handler
2019-07-19 09:09:45.836251 I  Setup Aborted handler
2019-07-19 09:09:45.836265 I  Setup Bus error handler
2019-07-19 09:09:45.836277 I  Setup Floating point exception handler
2019-07-19 09:09:45.836291 I  Setup Illegal instruction handler
2019-07-19 09:09:45.836335 I  Setup Real-time signal 0 handler
2019-07-19 09:09:45.836353 I  Setup Hangup handler
2019-07-19 09:09:45.836732 N  Using runtime prefix = /usr
2019-07-19 09:09:45.836739 N  Using configuration directory = /home/jsbien/.mythtv
2019-07-19 09:09:45.836943 I  Assumed character encoding: en_US.UTF-8
2019-07-19 09:09:45.837723 I  Empty LocalHostName. This is typical.
2019-07-19 09:09:45.837737 I  Using a profile name of: 'VivoPC-D8' (Usually the same as this host's name.)
2019-07-19 09:09:45.837794 I  UPNP Search up to 2 secs
2019-07-19 09:09:46.202611 I  UPNP Search up to 1 secs
2019-07-19 09:09:46.725979 I  UPNP Search up to 1 secs
2019-07-19 09:09:47.967232 A  Cannot find default UPnP backend
                              ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2019-07-19 09:09:47.967330 I  Start up testing connections. DB 127.0.0.1, BE , attempt 0, status dbAwake, Delay: 2000
2019-07-19 09:09:48.534610 N  Setting QT default locale to en_PL
2019-07-19 09:09:48.534627 I  Current locale en_PL
2019-07-19 09:09:48.534682 E  No locale defaults file for en_PL, skipping
2019-07-19 09:09:48.535636 I  Loading en_us translation for module mythfrontend
2019-07-19 09:09:48.540603 I  MythCoreContext::ConnectCommandSocket(): Connecting to backend server: 127.0.0.1:6543 (try 1 of 1)
2019-07-19 09:09:48.552355 I  MythCoreContext::CheckProtoVersion(): Using protocol version 91 BuzzOff
2019-07-19 09:09:48.554795 I  Sent 'SET_VERBOSE http:debug,upnp:debug' message
2019-07-19 09:09:49.155236 I  Waiting for threads to exit.
--8<---------------cut here---------------end--------------->8---

I guess the options should be active when the backend starts. Is editing
/etc/default/mythtv-backend the right way to do it or the file is just a
remnant of some pre-systemd installation?

While the frontend works almost normally (by "almost normally" I mean
there is a strange problem with displaying the program guide, but live
TV and playing recordings definitely work) I get

> Assuming the backend is listening: ss --options state all '( sport = 6544 or dport = 6544 )'

--8<---------------cut here---------------start------------->8---
Netid          State          Recv-Q          Send-Q                    Local Address:Port                     Peer Address:Port          
--8<---------------cut here---------------end--------------->8---


> Or test the backend with: nmap -p 6544 --reason yourBackend  expect to see:
> 6544/tcp open  mythtv  syn-ack on the last line of output.

--8<---------------cut here---------------start------------->8---
PORT     STATE  SERVICE
6544/tcp closed mythtv
--8<---------------cut here---------------end--------------->8---

On the other hand checking the backend status gives the output which I
don't understand:

--8<---------------cut here---------------start------------->8---
systemctl status mythtv-backend
● mythtv-backend.service - LSB: Start/Stop the MythTV server.
   Loaded: loaded (/etc/init.d/mythtv-backend; generated)
   Active: active (exited) since Fri 2019-07-19 09:14:29 CEST; 4min 25s ago
                   ^^^^^^ 
     Docs: man:systemd-sysv-generator(8)
  Process: 5685 ExecStart=/etc/init.d/mythtv-backend start (code=exited, status=0/SUCCESS)

Jul 19 09:14:33 VivoPC-D8 mythbackend[5693]: mythbackend[5693]: I CoreContext serverpool.cpp:415 (listen) Listening on TCP [::]:6554
Jul 19 09:14:33 VivoPC-D8 mythbackend[5693]: mythbackend[5693]: I CoreContext serverpool.cpp:415 (listen) Listening on TCP 0.0.0.0:6549
Jul 19 09:14:33 VivoPC-D8 mythbackend[5693]: mythbackend[5693]: I CoreContext serverpool.cpp:415 (listen) Listening on TCP [::]:6549
Jul 19 09:14:36 VivoPC-D8 mythbackend[5693]: mythbackend[5693]: I Scheduler scheduler.cpp:2357 (HandleReschedule) Reschedule requested for MATCH 0 0 0 - SchedulerInit
Jul 19 09:14:36 VivoPC-D8 mythbackend[5693]: mythbackend[5693]: I Scheduler scheduler.cpp:2473 (HandleReschedule) Scheduled 0 items in 0.0 = 0.00 match + 0.00 check + 0.01 place
Jul 19 09:14:36 VivoPC-D8 mythbackend[5693]: mythbackend[5693]: I Scheduler scheduler.cpp:2540 (HandleRunSchedulerStartup) Scheduler: Seem to be woken up by USER
Jul 19 09:14:40 VivoPC-D8 mythbackend[5693]: mythbackend[5693]: I CoreContext main_helpers.cpp:698 (run_backend) Main::Registering HttpStatus Extension
Jul 19 09:14:40 VivoPC-D8 mythbackend[5693]: mythbackend[5693]: E CoreContext serverpool.cpp:428 (listen) Failed listening on TCP 0.0.0.0:6543 - Error 8: The bound address is already in use
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Jul 19 09:14:40 VivoPC-D8 mythbackend[5693]: mythbackend[5693]: C CoreContext main_helpers.cpp:713 (run_backend) Backend exiting, MainServer initialization error.
Jul 19 09:14:40 VivoPC-D8 mythbackend[5693]: mythbackend[5693]: I CoreContext bonjourregister.cpp:28 (~BonjourRegister) Bonjour: De-registering service '' on ''
--8<---------------cut here---------------end--------------->8---


Best regards

Janusz

-- 
             ,   
Janusz S. Bien
emeryt (emeritus)
https://sites.google.com/view/jsbien

More information about the mythtv-users mailing list