Opened 12 years ago

Closed 12 years ago

Last modified 12 years ago

#11110 closed Bug Report - General (fixed)

Myth binaries frequently immediately exit with return code 162

Reported by: superm1@… Owned by: beirdo
Priority: minor Milestone: 0.26
Component: MythTV - General Version: Unspecified
Severity: medium Keywords:
Cc: Ticket locked: no

Description

I'm running on Ubuntu 12.04.1.

$ mythfrontend --version
Please attach all output as a file in bug reports.
MythTV Version : v0.26-rc2-21-g2861862
MythTV Branch : master
Network Protocol : 75
Library API : 0.26.20120822-1
QT Version : 4.8.1
Options compiled in:
 linux profile use_hidesyms using_alsa using_oss using_pulse using_pulseoutput using_backend using_bindings_perl using_bindings_python using_bindings_php using_crystalhd using_dvb using_firewire using_frontend using_hdhomerun using_ceton using_hdpvr using_iptv using_ivtv using_joystick_menu using_libcec using_libcrypto using_libdns_sd using_libxml2 using_lirc using_mheg using_opengl_video using_qtwebkit using_qtscript using_qtdbus using_v4l2 using_x11 using_xrandr using_xv using_bindings_perl using_bindings_python using_bindings_php using_mythtranscode using_opengl using_vaapi using_vdpau using_ffmpeg_threads using_live using_mheg using_libass using_libxml2

Approximately 90% of the time trying to start any myth binary (mythfrontend, mythtv-setup, mythbackend, mythfilldatabase) will cause an immediate exit at the command line. The return code when this happens is 162.

Here's an example of the behavior:

$ mythfilldatabase --dd-grab-all
2012-09-21 12:29:59.914532 C  mythfilldatabase version: master [v0.26-rc2-21-g2861862] www.mythtv.org
2012-09-21 12:29:59.914564 C  Qt version: compile: 4.8.1, runtime: 4.8.1
2012-09-21 12:29:59.914577 N  Enabled verbose msgs:  general
2012-09-21 12:29:59.914595 N  Setting Log Level to LOG_INFO
2012-09-21 12:29:59.916082 I  Setup Interrupt handler
2012-09-21 12:29:59.916103 I  Setup Terminated handler
2012-09-21 12:29:59.916116 I  Setup Segmentation fault handler
2012-09-21 12:29:59.916131 I  Setup Aborted handler
2012-09-21 12:29:59.916143 I  Setup Bus error handler
2012-09-21 12:29:59.916158 I  Setup Floating point exception handler
2012-09-21 12:29:59.916170 I  Setup Illegal instruction handler
2012-09-21 12:29:59.916240 N  Using runtime prefix = /usr
2012-09-21 12:29:59.916276 N  Using configuration directory = /home/supermario/.mythtv
2012-09-21 12:29:59.916412 I  Assumed character encoding: en_US.UTF-8
2012-09-21 12:29:59.916928 N  Empty LocalHostName.
2012-09-21 12:29:59.916937 I  Using localhost value of supermario
2012-09-21 12:29:59.928094 I  Added logging to the console
Real-time signal 0
$ echo $?
162

Attachments (1)

0001-Add-support-for-real-time-signal-0-handling.patch (17.2 KB) - added by beirdo 12 years ago.

Download all attachments as: .zip

Change History (6)

comment:1 Changed 12 years ago by beirdo

Owner: set to beirdo
Status: newassigned

This corresponds to signal 34. I'll look at putting in a handler for that signal tonight.

comment:2 Changed 12 years ago by beirdo

Please try the attached patch. I have confirmed it works fine in other usage, but I can't reproduce the issue at hand. It should fix it, and also log information as to the source of the SIGRTMIN signal. I would appreciate a sample log output line from when it hits with this patch in.

Changed 12 years ago by beirdo

comment:3 Changed 12 years ago by superm1@…

This fixes the problem. Here's the output. Note process 6227 is the mythfrontend process:

supermario@supermario:~$ DISPLAY=:0 mythfrontend
2012-09-24 12:04:06.507322 I  Setup Interrupt handler
2012-09-24 12:04:06.507361 I  Setup Terminated handler
2012-09-24 12:04:06.507374 I  Setup Segmentation fault handler
2012-09-24 12:04:06.507390 I  Setup Aborted handler
2012-09-24 12:04:06.507402 I  Setup Bus error handler
2012-09-24 12:04:06.507418 I  Setup Floating point exception handler
2012-09-24 12:04:06.507429 I  Setup Illegal instruction handler
2012-09-24 12:04:06.507450 I  Setup Real-time signal 0 handler
2012-09-24 12:04:06.507474 I  Setup User defined signal 1 handler
2012-09-24 12:04:06.507486 I  Setup User defined signal 2 handler
2012-09-24 12:04:06.507681 C  mythfrontend version: master [v0.26-rc2-43-g8611c6e] www.mythtv.org
2012-09-24 12:04:06.507695 C  Qt version: compile: 4.8.1, runtime: 4.8.1
2012-09-24 12:04:06.507707 N  Enabled verbose msgs:  general
2012-09-24 12:04:06.507728 N  Setting Log Level to LOG_INFO
2012-09-24 12:04:06.508060 N  Using runtime prefix = /usr
2012-09-24 12:04:06.508085 N  Using configuration directory = /home/supermario/.mythtv
2012-09-24 12:04:06.508233 I  Assumed character encoding: en_US.UTF-8
2012-09-24 12:04:06.508956 N  Empty LocalHostName.
2012-09-24 12:04:06.508974 I  Using localhost value of supermario
2012-09-24 12:04:06.513401 I  Added logging to the console
2012-09-24 12:04:06.721242 N  Setting QT default locale to EN_US
2012-09-24 12:04:06.721358 I  Current locale EN_US
2012-09-24 12:04:06.721443 N  Reading locale defaults from /usr/share/mythtv//locales/en_us.xml
2012-09-24 12:04:06.737573 I  Starting IO manager (write)
2012-09-24 12:04:06.737697 I  Starting IO manager (read)
2012-09-24 12:04:06.737836 I  Starting process signal handler
2012-09-24 12:04:06.737949 I  Starting process manager
2012-09-24 12:04:06.741430 I  Starting mythlogserver
2012-09-24 12:04:06.841410 I  ScreenSaverX11Private: XScreenSaver support enabled
2012-09-24 12:04:06.842857 I  ScreenSaverX11Private: DPMS is disabled.
2012-09-24 12:04:06.869796 N  Desktop video mode: 1920x1080 60.000 Hz
2012-09-24 12:04:06.979168 I  Listening on TCP 127.0.0.1:6547
2012-09-24 12:04:06.979298 I  Listening on TCP 192.168.1.147:6547
2012-09-24 12:04:06.979403 I  Listening on TCP [::1]:6547
2012-09-24 12:04:06.979497 I  Listening on TCP [fe80::224:8cff:fec3:181e%eth0]:6547
2012-09-24 12:04:07.142224 I  Added logging to mythlogserver at TCP:35327
2012-09-24 12:04:08.102217 E  RAOP Conn: Failed to read key from: /home/supermario/.mythtv/RAOPKey.rsa
2012-09-24 12:04:08.102257 E  RAOP Device: Aborting startup - no key found.
2012-09-24 12:04:08.104672 I  AirPlay: Created airplay objects.
2012-09-24 12:04:08.107861 I  Listening on TCP 127.0.0.1:5100
2012-09-24 12:04:08.108041 I  Listening on TCP 192.168.1.147:5100
2012-09-24 12:04:08.108236 I  Listening on TCP [::1]:5100
2012-09-24 12:04:08.108421 I  Listening on TCP [fe80::224:8cff:fec3:181e%eth0]:5100
2012-09-24 12:04:08.127749 I  Loading en_us translation for module mythfrontend
cannot find libcec.solibcec.so: cannot open shared object file: No such file or directory
2012-09-24 12:04:08.174771 I  LIRC: Successfully initialized '/dev/lircd' using '/home/supermario/.mythtv/lircrc' config
2012-09-24 12:04:08.175048 E  JoystickMenuThread: Joystick disabled - Failed to read /home/supermario/.mythtv/joystickmenurc
2012-09-24 12:04:08.203864 E  CECAdapter: Failed to load libcec.
2012-09-24 12:04:08.203955 I  UDPListener: Enabling
2012-09-24 12:04:08.207087 I  Binding to UDP 127.0.0.1:6948
2012-09-24 12:04:08.207260 I  Binding to UDP 192.168.1.147:6948
2012-09-24 12:04:08.207446 I  Binding to UDP [::1]:6948
2012-09-24 12:04:08.207630 I  Binding to UDP [fe80::224:8cff:fec3:181e%eth0]:6948
2012-09-24 12:04:08.207786 I  Binding to UDP 192.168.1.255:6948
2012-09-24 12:04:08.314141 I  Using Frameless Window
2012-09-24 12:04:08.314229 I  Using Full Screen Window
2012-09-24 12:04:08.539492 I  Trying the OpenGL painter
2012-09-24 12:04:08.565035 W  NVCtrl: OpenGL Sync to VBlank is disabled.
2012-09-24 12:04:08.565049 W  NVCtrl: For best results enable this in NVidia settings or try running:
2012-09-24 12:04:08.565055 W  NVCtrl: nvidia-settings -a "SyncToVBlank=1"
2012-09-24 12:04:08.565084 W  NVCtrl: Alternatively try setting the '__GL_SYNC_TO_VBLANK' environment variable.
2012-09-24 12:04:08.638740 I  OpenGL1: Fragment program support available
2012-09-24 12:04:08.638837 I  OpenGL: OpenGL vendor  : NVIDIA Corporation
2012-09-24 12:04:08.638848 I  OpenGL: OpenGL renderer: GeForce 9500 GT/PCIe/SSE2/3DNOW!
2012-09-24 12:04:08.638855 I  OpenGL: OpenGL version : 3.3.0 NVIDIA 295.40
2012-09-24 12:04:08.638869 I  OpenGL: Max texture size: 8192 x 8192
2012-09-24 12:04:08.638876 I  OpenGL: Max texture units: 4
2012-09-24 12:04:08.638884 I  OpenGL: Direct rendering: Yes
2012-09-24 12:04:08.638895 I  OpenGL: PixelBufferObject support available
2012-09-24 12:04:08.638901 I  OpenGL: Initialised MythRenderOpenGL
2012-09-24 12:04:08.902332 I  Current MythTV Schema Version (DBSchemaVer): 1307
2012-09-24 12:04:09.036771 I  Bonjour: Service registration complete: name 'MythTV on supermario' type '_airplay._tcp.' domain: 'local.'
2012-09-24 12:04:09.052005 W  ThemeInfo: Unable to open themeinfo.xml for /usr/share/mythtv/themes/BlackCurves-OSD/themeinfo.xml
2012-09-24 12:04:09.052026 E  ThemeInfo: The theme (/usr/share/mythtv/themes/BlackCurves-OSD) is missing a themeinfo.xml file.
2012-09-24 12:04:09.052790 W  ThemeInfo: Unable to open themeinfo.xml for /usr/share/mythtv/themes/Gray-OSD/themeinfo.xml
2012-09-24 12:04:09.052828 E  ThemeInfo: The theme (/usr/share/mythtv/themes/Gray-OSD) is missing a themeinfo.xml file.
2012-09-24 12:04:09.173187 E  RAOP Conn: Failed to read key from: /home/supermario/.mythtv/RAOPKey.rsa
2012-09-24 12:04:09.405393 N  Registering Internal as a media playback plugin.
2012-09-24 12:04:09.484797 I  Loading en_us translation for module mytharchive
2012-09-24 12:04:09.492039 N  Registering WebBrowser as a media playback plugin.
2012-09-24 12:04:09.492209 I  Loading en_us translation for module mythbrowser
2012-09-24 12:04:09.495922 I  Loading en_us translation for module mythnetvision
2012-09-24 12:04:09.498811 I  Listening on TCP 127.0.0.1:6546
2012-09-24 12:04:09.498894 I  Listening on TCP 192.168.1.147:6546
2012-09-24 12:04:09.498987 I  Listening on TCP [::1]:6546
2012-09-24 12:04:09.499077 I  Listening on TCP [fe80::224:8cff:fec3:181e%eth0]:6546
2012-09-24 12:04:09.502240 I  Last hardware profile update was > 30 days ago, update required...
2012-09-24 12:04:09.502339 I  Locking input devices
2012-09-24 12:04:10.987430 N  Found mainmenu.xml for theme 'Mythbuntu'
2012-09-24 12:04:11.018428 I  Unlocking input devices
2012-09-24 12:04:11.374050 C  Received Real-time signal 0: Code -6, PID 6227, UID 1000, Value 0xffffffffed0a6180
2012-09-24 12:04:11.374067 C  Recieved unexpected signal 34
2012-09-24 12:04:11.386449 I  Bonjour: Service registration complete: name 'Mythfrontend on supermario' type '_mythfrontend._tcp.' domain: 'local.'
2012-09-24 12:04:26.016138 I  MythCoreContext: Connecting to backend server: 192.168.1.147:6543 (try 1 of 1)
2012-09-24 12:04:26.020128 I  Using protocol version 75
2012-09-24 12:04:26.103363 I  Using protocol version 75
2012-09-24 12:04:26.108937 I  Using protocol version 75

comment:4 Changed 12 years ago by Gavin Hurlbut <ghurlbut@…>

Resolution: fixed
Status: assignedclosed

In c7f0676059a6e901b760e596750876783502c1a5/mythtv:

Add support for real time signal 0 handling

Fixes #11110

Seems that some setups (in particular Ubuntu 12.04) are seeing our applications
getting killed by SIGRTMIN. As I have no clue what is causing this, I am
changing the signal handling to use sigaction's extended handlers that hand
off siginfo_t as well. This gives us the source of the signal.

Additionally, I added a default handler for SIGRTMIN. This should end that
nuisance.

comment:5 Changed 12 years ago by Raymond Wagner

Milestone: unknown0.26
Note: See TracTickets for help on using tickets.