mythbackend --version Please attach all output as a file in bug reports. MythTV Version : v0.26.0-28-ge3087dd MythTV Branch : fixes/0.26 Network Protocol : 75 Library API : 0.26.20120822-1 QT Version : 4.8.3 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 tail /var/log/kern.log ... Oct 30 08:30:27 mythbox kernel: [ 17.220203] lirc_dev: IR Remote Control driver registered, major 250 Oct 30 08:30:27 mythbox kernel: [ 17.221995] lirc_zilog: module is from the staging directory, the quality is unknown, you have been warned. Oct 30 08:30:27 mythbox kernel: [ 17.222794] lirc_zilog: Zilog/Hauppauge IR driver initializing Oct 30 08:30:27 mythbox kernel: [ 17.225861] lirc_zilog: initialization complete Oct 30 08:30:27 mythbox kernel: [ 17.396210] lirc_zilog: probing IR Tx on Hauppage HD PVR I2C (i2c-0) Oct 30 08:30:27 mythbox kernel: [ 17.404198] i2c i2c-0: >lirc_dev: driver lirc_zilog registered at minor = 0 Oct 30 08:30:27 mythbox kernel: [ 17.404203] lirc_zilog: IR unit on Hauppage HD PVR I2C (i2c-0) registered as lirc0 and ready Oct 30 08:30:27 mythbox kernel: [ 17.404205] lirc_zilog: probe of IR Tx on Hauppage HD PVR I2C (i2c-0) done Oct 30 08:30:27 mythbox kernel: [ 17.404244] hdpvr 1-1:1.0: device now attached to video0 Oct 30 08:30:27 mythbox kernel: [ 17.404276] usbcore: registered new interface driver hdpvr Oct 30 08:30:27 mythbox kernel: [ 17.433072] intel8x0_measure_ac97_clock: measured 56740 usecs (7680 samples) Oct 30 08:30:27 mythbox kernel: [ 17.433075] intel8x0: measured clock 135354 rejected Oct 30 08:30:27 mythbox kernel: [ 17.502217] vboxsf: Successfully loaded version 4.2.0 (interface 0x00010004) Oct 30 08:30:27 mythbox kernel: [ 17.792267] intel8x0_measure_ac97_clock: measured 55992 usecs (7680 samples) Oct 30 08:30:27 mythbox kernel: [ 17.792271] intel8x0: measured clock 137162 rejected Oct 30 08:30:27 mythbox kernel: [ 17.792273] intel8x0: clocking to 48000 Oct 30 08:30:28 mythbox kernel: [ 17.843786] vesafb: mode is 640x480x32, linelength=2560, pages=0 Oct 30 08:30:28 mythbox kernel: [ 17.843790] vesafb: scrolling: redraw Oct 30 08:30:28 mythbox kernel: [ 17.843792] vesafb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Oct 30 08:30:28 mythbox kernel: [ 17.843805] mtrr: your processor doesn't support write-combining Oct 30 08:30:28 mythbox kernel: [ 17.843890] vesafb: framebuffer at 0xe0000000, mapped to 0xffffc90002280000, using 1216k, total 1216k Oct 30 08:30:28 mythbox kernel: [ 17.844590] Console: switching to colour frame buffer device 80x30 Oct 30 08:30:28 mythbox kernel: [ 17.844609] fb0: VESA VGA frame buffer device Oct 30 08:30:28 mythbox kernel: [ 18.090810] sf_read_super_aux err=-71 Oct 30 08:30:28 mythbox kernel: [ 18.099333] sf_read_super_aux err=-71 Oct 30 08:30:28 mythbox kernel: [ 18.111628] sf_read_super_aux err=-71 Oct 30 08:30:30 mythbox kernel: [ 20.582080] lirc_zilog: Zilog/Hauppauge IR blaster firmware version 2.1.0 loaded Oct 30 08:30:32 mythbox kernel: [ 22.210950] ------------[ cut here ]------------ Oct 30 08:30:32 mythbox kernel: [ 22.210958] WARNING: at /build/buildd/linux-3.5.0/fs/dcache.c:1375 d_set_d_op+0x7c/0xb0() Oct 30 08:30:32 mythbox kernel: [ 22.210960] Hardware name: VirtualBox Oct 30 08:30:32 mythbox kernel: [ 22.210961] Modules linked in: vesafb vboxsf(O) lirc_zilog(C) lirc_dev ppdev snd_intel8x0 snd_ac97_codec ac97_bus joydev snd_pcm snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq hdpvr v4l2_common snd_timer snd_seq_device videodev microcode snd psmouse serio_raw parport_pc soundcore snd_page_alloc mac_hid vboxguest(O) i2c_piix4 lp parport hid_generic usbhid hid e1000 Oct 30 08:30:32 mythbox kernel: [ 22.210983] Pid: 1837, comm: mythbackend Tainted: G C O 3.5.0-17-generic #28-Ubuntu Oct 30 08:30:32 mythbox kernel: [ 22.210984] Call Trace: Oct 30 08:30:32 mythbox kernel: [ 22.210990] [] warn_slowpath_common+0x7f/0xc0 Oct 30 08:30:32 mythbox kernel: [ 22.210992] [] warn_slowpath_null+0x1a/0x20 Oct 30 08:30:32 mythbox kernel: [ 22.210994] [] d_set_d_op+0x7c/0xb0 Oct 30 08:30:32 mythbox kernel: [ 22.210998] [] sf_instantiate.isra.1+0xcb/0x180 [vboxsf] Oct 30 08:30:32 mythbox kernel: [ 22.211001] [] sf_create_aux+0x1ac/0x250 [vboxsf] Oct 30 08:30:32 mythbox kernel: [ 22.211004] [] sf_create+0x13/0x20 [vboxsf] Oct 30 08:30:32 mythbox kernel: [ 22.211006] [] vfs_create+0xb4/0x120 Oct 30 08:30:32 mythbox kernel: [ 22.211007] [] do_last+0x8ab/0xa10 Oct 30 08:30:32 mythbox kernel: [ 22.211011] [] ? apparmor_file_alloc_security+0x2c/0x60 Oct 30 08:30:32 mythbox kernel: [ 22.211013] [] path_openat+0xd9/0x430 Oct 30 08:30:32 mythbox kernel: [ 22.211016] [] ? sf_inode_revalidate+0xae/0xd0 [vboxsf] Oct 30 08:30:32 mythbox kernel: [ 22.211018] [] do_filp_open+0x41/0xa0 Oct 30 08:30:32 mythbox kernel: [ 22.211020] [] ? alloc_fd+0xc6/0x110 Oct 30 08:30:32 mythbox kernel: [ 22.211023] [] do_sys_open+0xf5/0x230 Oct 30 08:30:32 mythbox kernel: [ 22.211036] [] sys_open+0x21/0x30 Oct 30 08:30:32 mythbox kernel: [ 22.211041] [] system_call_fastpath+0x16/0x1b Oct 30 08:30:32 mythbox kernel: [ 22.211042] ---[ end trace 52ccb644471ff58c ]--- Oct 30 08:30:32 mythbox kernel: [ 22.211043] ------------[ cut here ]------------ Oct 30 08:30:32 mythbox kernel: [ 22.211045] WARNING: at /build/buildd/linux-3.5.0/fs/dcache.c:1379 d_set_d_op+0x9f/0xb0() Oct 30 08:30:32 mythbox kernel: [ 22.211046] Hardware name: VirtualBox Oct 30 08:30:32 mythbox kernel: [ 22.211046] Modules linked in: vesafb vboxsf(O) lirc_zilog(C) lirc_dev ppdev snd_intel8x0 snd_ac97_codec ac97_bus joydev snd_pcm snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq hdpvr v4l2_common snd_timer snd_seq_device videodev microcode snd psmouse serio_raw parport_pc soundcore snd_page_alloc mac_hid vboxguest(O) i2c_piix4 lp parport hid_generic usbhid hid e1000 Oct 30 08:30:32 mythbox kernel: [ 22.211062] Pid: 1837, comm: mythbackend Tainted: G WC O 3.5.0-17-generic #28-Ubuntu Oct 30 08:30:32 mythbox kernel: [ 22.211063] Call Trace: Oct 30 08:30:32 mythbox kernel: [ 22.211065] [] warn_slowpath_common+0x7f/0xc0 Oct 30 08:30:32 mythbox kernel: [ 22.211068] [] warn_slowpath_null+0x1a/0x20 Oct 30 08:30:32 mythbox kernel: [ 22.211069] [] d_set_d_op+0x9f/0xb0 Oct 30 08:30:32 mythbox kernel: [ 22.211072] [] sf_instantiate.isra.1+0xcb/0x180 [vboxsf] Oct 30 08:30:32 mythbox kernel: [ 22.211075] [] sf_create_aux+0x1ac/0x250 [vboxsf] Oct 30 08:30:32 mythbox kernel: [ 22.211077] [] sf_create+0x13/0x20 [vboxsf] Oct 30 08:30:32 mythbox kernel: [ 22.211079] [] vfs_create+0xb4/0x120 Oct 30 08:30:32 mythbox kernel: [ 22.211081] [] do_last+0x8ab/0xa10 Oct 30 08:30:32 mythbox kernel: [ 22.211083] [] ? apparmor_file_alloc_security+0x2c/0x60 Oct 30 08:30:32 mythbox kernel: [ 22.211085] [] path_openat+0xd9/0x430 Oct 30 08:30:32 mythbox kernel: [ 22.211087] [] ? sf_inode_revalidate+0xae/0xd0 [vboxsf] Oct 30 08:30:32 mythbox kernel: [ 22.211089] [] do_filp_open+0x41/0xa0 Oct 30 08:30:32 mythbox kernel: [ 22.211091] [] ? alloc_fd+0xc6/0x110 Oct 30 08:30:32 mythbox kernel: [ 22.211093] [] do_sys_open+0xf5/0x230 Oct 30 08:30:32 mythbox kernel: [ 22.211095] [] sys_open+0x21/0x30 Oct 30 08:30:32 mythbox kernel: [ 22.211097] [] system_call_fastpath+0x16/0x1b Oct 30 08:30:32 mythbox kernel: [ 22.211098] ---[ end trace 52ccb644471ff58d ]--- tail /var/log/mythtv/mythbackend.log (during relevant time) Oct 30 08:30:30 mythbox mythlogserver: mythbackend[1837]: I CoreContext serverpool.cpp:395 (listen) Listening on TCP [::1]:6544 Oct 30 08:30:30 mythbox mythlogserver: mythbackend[1837]: I CoreContext serverpool.cpp:395 (listen) Listening on TCP [fe80::a00:27ff:fe95:883b%eth1]:6544 Oct 30 08:30:32 mythbox mythlogserver: mythbackend[1837]: I CoreContext main_helpers.cpp:645 (run_backend) Main::Registering HttpStatus Extension Oct 30 08:30:32 mythbox mythlogserver: mythbackend[1837]: I CoreContext serverpool.cpp:395 (listen) Listening on TCP 127.0.0.1:6543 Oct 30 08:30:32 mythbox mythlogserver: mythbackend[1837]: I CoreContext serverpool.cpp:395 (listen) Listening on TCP 192.168.2.128:6543 Oct 30 08:30:32 mythbox mythlogserver: mythbackend[1837]: I CoreContext serverpool.cpp:395 (listen) Listening on TCP [::1]:6543 Oct 30 08:30:32 mythbox mythlogserver: mythbackend[1837]: I CoreContext serverpool.cpp:395 (listen) Listening on TCP [fe80::a00:27ff:fe95:883b%eth1]:6543 Oct 30 08:30:32 mythbox mythlogserver: mythbackend[1837]: N CoreContext autoexpire.cpp:264 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 1.0 GB w/freq: 15 min Oct 30 08:30:33 mythbox mythlogserver: mythbackend[1837]: I CoreContext bonjourregister.cpp:100 (BonjourCallback) Bonjour: Service registration complete: name 'Mythbackend on mythbox' type '_mythbackend-master._tcp.' domain: 'local.' Oct 30 08:30:33 mythbox mythlogserver: mythbackend[1837]: I ProcessRequest mainserver.cpp:1445 (HandleAnnounce) adding: mythfe as a slave backend server Oct 30 08:30:33 mythbox mythlogserver: mythbackend[1837]: I Scheduler scheduler.cpp:2126 (HandleReschedule) Reschedule requested for MATCH 0 0 0 - SchedulerInit Oct 30 08:30:37 mythbox mythlogserver: mythbackend[1837]: I ProcessRequest mainserver.cpp:1395 (HandleAnnounce) MainServer::ANN Monitor Oct 30 08:30:37 mythbox mythlogserver: mythbackend[1837]: I ProcessRequest mainserver.cpp:1397 (HandleAnnounce) adding: mythfe as a client (events: 0) Oct 30 08:30:37 mythbox mythlogserver: mythbackend[1837]: I ProcessRequest mainserver.cpp:1395 (HandleAnnounce) MainServer::ANN Monitor Oct 30 08:30:37 mythbox mythlogserver: mythbackend[1837]: I ProcessRequest mainserver.cpp:1397 (HandleAnnounce) adding: mythfe as a client (events: 1) Oct 30 08:30:40 mythbox mythlogserver: mythbackend[1837]: I HouseKeeping housekeeper.cpp:221 (RunHouseKeeping) Running housekeeping thread Oct 30 08:30:40 mythbox mythlogserver: mythbackend[1837]: I HouseKeeping housekeeper.cpp:309 (RunHouseKeeping) Running mythfilldatabase Oct 30 08:30:42 mythbox mythlogserver: mythbackend[1837]: I Scheduler scheduler.cpp:2239 (HandleReschedule) Scheduled 300 items in 9.0 = 8.66 match + 0.28 check + 0.10 place Oct 30 08:30:43 mythbox mythlogserver: mythbackend[1837]: I Scheduler scheduler.cpp:2306 (HandleRunSchedulerStartup) Scheduler: Seem to be woken up by USER Oct 30 08:31:09 mythbox mythlogserver: mythbackend[1837]: E Update mythsocket.cpp:520 (readStringList) MythSocket(fbee20:67): readStringList: Error, timed out after 30000 ms. Oct 30 08:31:09 mythbox mythlogserver: mythbackend[1837]: E Update mainserver.cpp:5738 (connectionClosed) Slave backend: mythfe no longer connected