Further observation: doesn't seem to be a timing problem / race
condition right after system init as this behaviour persists way beyond
boot stage, ie. is reproducible all along the way.

What would be of great help to track this down is what exit code 127
from the backend exactly means. Esp. as the backend exits before ANY
logging information is produced...

Here's what initctl produced when setting the log level to debug:

Jan  3 08:10:58 htpc kernel: [ 1443.013593] init: mythtv-backend goal changed 
from stop to start
Jan  3 08:10:58 htpc kernel: [ 1443.013954] init: mythtv-backend state changed 
from waiting to starting
Jan  3 08:10:58 htpc kernel: [ 1443.014288] init: event_new: Pending starting 
event
Jan  3 08:10:58 htpc kernel: [ 1443.014366] init: Handling starting event
Jan  3 08:10:58 htpc kernel: [ 1443.014588] init: event_finished: Finished 
starting event
Jan  3 08:10:58 htpc kernel: [ 1443.014634] init: mythtv-backend state changed 
from starting to pre-start
Jan  3 08:10:58 htpc kernel: [ 1443.016178] init: mythtv-backend pre-start 
process (2959)
Jan  3 08:10:58 htpc kernel: [ 1443.032549] init: mythtv-backend pre-start 
process (2959) exited normally
Jan  3 08:10:58 htpc kernel: [ 1443.032769] init: mythtv-backend state changed 
from pre-start to spawned
Jan  3 08:10:58 htpc kernel: [ 1443.034070] init: mythtv-backend main process 
(2965)
Jan  3 08:10:58 htpc kernel: [ 1443.034206] init: mythtv-backend state changed 
from spawned to post-start
Jan  3 08:10:58 htpc kernel: [ 1443.034439] init: mythtv-backend state changed 
from post-start to running
Jan  3 08:10:58 htpc kernel: [ 1443.034581] init: event_new: Pending started 
event
Jan  3 08:10:58 htpc kernel: [ 1443.034692] init: Handling started event
Jan  3 08:10:58 htpc kernel: [ 1443.035086] init: event_finished: Finished 
started event
Jan  3 08:10:58 htpc Myth upstart: Tue Jan 3 08:10:58 CET 2012
Jan  3 08:10:58 htpc kernel: [ 1443.045415] init: mythtv-backend main process 
(2965) terminated with status 127
Jan  3 08:10:58 htpc kernel: [ 1443.045444] init: mythtv-backend main process 
ended, respawning
Jan  3 08:10:58 htpc kernel: [ 1443.045513] init: mythtv-backend state changed 
from running to stopping
Jan  3 08:10:58 htpc kernel: [ 1443.045596] init: event_new: Pending stopping 
event
Jan  3 08:10:58 htpc kernel: [ 1443.045650] init: Handling stopping event
Jan  3 08:10:58 htpc kernel: [ 1443.045719] init: event_finished: Finished 
stopping event
Jan  3 08:10:58 htpc kernel: [ 1443.045733] init: mythtv-backend state changed 
from stopping to killed
Jan  3 08:10:58 htpc kernel: [ 1443.045771] init: mythtv-backend state changed 
from killed to post-stop
Jan  3 08:10:58 htpc kernel: [ 1443.045804] init: mythtv-backend state changed 
from post-stop to starting
Jan  3 08:10:58 htpc kernel: [ 1443.045840] init: event_new: Pending starting 
event
Jan  3 08:10:58 htpc kernel: [ 1443.045855] init: Handling starting event
Jan  3 08:10:58 htpc kernel: [ 1443.045908] init: event_finished: Finished 
starting event
Jan  3 08:10:58 htpc kernel: [ 1443.045921] init: mythtv-backend state changed 
from starting to pre-start
Jan  3 08:10:58 htpc kernel: [ 1443.047490] init: mythtv-backend pre-start 
process (2969)
Jan  3 08:10:58 htpc kernel: [ 1443.060452] init: mythtv-backend pre-start 
process (2969) exited normally
Jan  3 08:10:58 htpc kernel: [ 1443.060551] init: mythtv-backend state changed 
from pre-start to spawned
Jan  3 08:10:58 htpc kernel: [ 1443.061526] init: mythtv-backend main process 
(2975)
Jan  3 08:10:58 htpc kernel: [ 1443.061713] init: mythtv-backend state changed 
from spawned to post-start
Jan  3 08:10:58 htpc kernel: [ 1443.062085] init: mythtv-backend state changed 
from post-start to running
Jan  3 08:10:58 htpc kernel: [ 1443.062351] init: event_new: Pending started 
event
Jan  3 08:10:58 htpc kernel: [ 1443.062427] init: Handling started event
Jan  3 08:10:58 htpc kernel: [ 1443.062797] init: event_finished: Finished 
started event
Jan  3 08:10:58 htpc Myth upstart: Tue Jan 3 08:10:58 CET 2012
Jan  3 08:10:58 htpc kernel: [ 1443.073113] init: mythtv-backend main process 
(2975) terminated with status 127
Jan  3 08:10:58 htpc kernel: [ 1443.073184] init: mythtv-backend main process 
ended, respawning
Jan  3 08:10:58 htpc kernel: [ 1443.073372] init: mythtv-backend state changed 
from running to stopping
Jan  3 08:10:58 htpc kernel: [ 1443.073590] init: event_new: Pending stopping 
event
Jan  3 08:10:58 htpc kernel: [ 1443.073652] init: Handling stopping event
Jan  3 08:10:58 htpc kernel: [ 1443.073835] init: event_finished: Finished 
stopping event
Jan  3 08:10:58 htpc kernel: [ 1443.073881] init: mythtv-backend state changed 
from stopping to killed
Jan  3 08:10:58 htpc kernel: [ 1443.074016] init: mythtv-backend state changed 
from killed to post-stop
Jan  3 08:10:58 htpc kernel: [ 1443.074134] init: mythtv-backend state changed 
from post-stop to starting
Jan  3 08:10:58 htpc kernel: [ 1443.074259] init: event_new: Pending starting 
event
Jan  3 08:10:58 htpc kernel: [ 1443.074311] init: Handling starting event
Jan  3 08:10:58 htpc kernel: [ 1443.074495] init: event_finished: Finished 
starting event
Jan  3 08:10:58 htpc kernel: [ 1443.074540] init: mythtv-backend state changed 
from starting to pre-start
Jan  3 08:10:58 htpc kernel: [ 1443.075501] init: mythtv-backend pre-start 
process (2979)
Jan  3 08:10:58 htpc kernel: [ 1443.093153] init: mythtv-backend pre-start 
process (2979) exited normally
Jan  3 08:10:58 htpc kernel: [ 1443.093353] init: mythtv-backend state changed 
from pre-start to spawned
Jan  3 08:10:58 htpc kernel: [ 1443.095702] init: mythtv-backend main process 
(2985)
Jan  3 08:10:58 htpc kernel: [ 1443.095868] init: mythtv-backend state changed 
from spawned to post-start
Jan  3 08:10:58 htpc kernel: [ 1443.096120] init: mythtv-backend state changed 
from post-start to running
Jan  3 08:10:58 htpc kernel: [ 1443.096331] init: event_new: Pending started 
event
Jan  3 08:10:58 htpc kernel: [ 1443.096414] init: Handling started event
Jan  3 08:10:58 htpc kernel: [ 1443.096782] init: event_finished: Finished 
started event
Jan  3 08:10:58 htpc Myth upstart: Tue Jan 3 08:10:58 CET 2012
Jan  3 08:10:58 htpc kernel: [ 1443.108234] init: mythtv-backend main process 
(2985) terminated with status 127
Jan  3 08:10:58 htpc kernel: [ 1443.108293] init: mythtv-backend respawning too 
fast, stopped
Jan  3 08:10:58 htpc kernel: [ 1443.108624] init: mythtv-backend goal changed 
from start to stop
Jan  3 08:10:58 htpc kernel: [ 1443.108741] init: mythtv-backend state changed 
from running to stopping
Jan  3 08:10:58 htpc kernel: [ 1443.108874] init: event_new: Pending stopping 
event
Jan  3 08:10:58 htpc kernel: [ 1443.108938] init: Handling stopping event
Jan  3 08:10:58 htpc kernel: [ 1443.109122] init: event_finished: Finished 
stopping event
Jan  3 08:10:58 htpc kernel: [ 1443.109167] init: mythtv-backend state changed 
from stopping to killed
Jan  3 08:10:58 htpc kernel: [ 1443.109280] init: mythtv-backend state changed 
from killed to post-stop
Jan  3 08:10:58 htpc kernel: [ 1443.109391] init: mythtv-backend state changed 
from post-stop to waiting
Jan  3 08:10:58 htpc kernel: [ 1443.109528] init: event_new: Pending stopped 
event
Jan  3 08:10:58 htpc kernel: [ 1443.109592] init: job_change_state: Destroyed 
inactive instance mythtv-backend
Jan  3 08:10:58 htpc kernel: [ 1443.109753] init: Handling stopped event
Jan  3 08:10:58 htpc kernel: [ 1443.109918] init: event_finished: Finished 
stopped event

-- 
You received this bug notification because you are a member of Ubuntu
Bugs, which is subscribed to Ubuntu.
https://bugs.launchpad.net/bugs/886321

Title:
  Upstart issue and mythbackend

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/mythtv/+bug/886321/+subscriptions

-- 
ubuntu-bugs mailing list
[email protected]
https://lists.ubuntu.com/mailman/listinfo/ubuntu-bugs

Reply via email to