2010-01-10 16:35:01  CRITICAL  gm.logging (/home/jbusser/gm/rc4/Gnumed/pycommon/gmLog2.py::__setup_logging() #231): -------- start of logging ------------------------------
2010-01-10 16:35:01  INFO      gm.logging (/home/jbusser/gm/rc4/Gnumed/pycommon/gmLog2.py::__setup_logging() #232): log file is </home/jbusser/gm/rc4/client/gm-from-cvs.log>
2010-01-10 16:35:01  INFO      gm.logging (/home/jbusser/gm/rc4/Gnumed/pycommon/gmLog2.py::__setup_logging() #233): log level is [DEBUG]
2010-01-10 16:35:01  INFO      gm.logging (/home/jbusser/gm/rc4/Gnumed/pycommon/gmLog2.py::__setup_logging() #234): log file encoding is <utf8>
2010-01-10 16:35:01  INFO      gm.logging (/home/jbusser/gm/rc4/Gnumed/pycommon/gmLog2.py::__setup_logging() #235): initial python.str -> python.unicode encoding is <ANSI_X3.4-1968>
2010-01-10 16:35:01  INFO      gm.launcher (wxpython/gnumed.py::<module>() #463): Starting up as main module ($Revision: 1.166 $).
2010-01-10 16:35:01  INFO      gm.launcher (wxpython/gnumed.py::<module>() #464): GNUmed client version [0.6.rc4] on branch [0.6]
2010-01-10 16:35:01  INFO      gm.launcher (wxpython/gnumed.py::<module>() #465): Platform: ('Linux', 'ubuntu', '2.6.31-17-generic', '#54-Ubuntu SMP Thu Dec 10 17:01:44 UTC 2009', 'x86_64', '')
2010-01-10 16:35:01  INFO      gm.launcher (wxpython/gnumed.py::<module>() #466): Python 2.6.4 (r264:75706, Dec  7 2009, 18:43:55) 
[GCC 4.4.1] on linux2 (posix)
2010-01-10 16:35:01  INFO      gm.launcher (wxpython/gnumed.py::<module>() #469): {'RELEASE': '9.10', 'CODENAME': 'karmic', 'ID': 'Ubuntu', 'DESCRIPTION': 'Ubuntu 9.10'}
2010-01-10 16:35:01  INFO      gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::<module>() #29): $Revision: 1.96 $
2010-01-10 16:35:01  INFO      gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::<module>() #19): $Revision: 1.20 $
2010-01-10 16:35:01  INFO      gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_cli() #430): adding command line arguments
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_cli() #431): raw command line is:
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_cli() #432): ['wxpython/gnumed.py', '--log-file=gm-from-cvs.log', '--conf-file=gm-from-cvs.conf', '--override-schema-check', '--skip-update-check', '--local-import', '--debug']
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [cli::--debug] found in source [cli]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [--slave] not in group [cli] in source [cli]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [cli::--skip-update-check] found in source [cli]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [--hipaa] not in group [cli] in source [cli]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [cli::--local-import] found in source [cli]
2010-01-10 16:35:01  INFO      gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::<module>() #63): $Revision: 1.48 $
2010-01-10 16:35:01  INFO      gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::<module>() #58): $Revision: 1.34 $
2010-01-10 16:35:01  INFO      gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::<module>() #59): mx.DateTime version: 3.1.2
2010-01-10 16:35:01  INFO      gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #36): $Revision: 1.18 $
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #69): known hooks:
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): post_patient_activation
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): shutdown-post-GUI
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): startup-after-GUI-init
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): startup-before-GUI
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): request_user_attention
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): app_activated_startup
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): app_activated
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): app_deactivated
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): after_new_doc_created
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): before_print_doc
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): before_fax_doc
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): before_mail_doc
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): before_print_doc_part
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): before_fax_doc_part
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): before_mail_doc_part
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): before_external_doc_access
2010-01-10 16:35:01  DEBUG     gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::<module>() #71): db_maintenance_warning
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #125): unmodified startup locale settings (should be [C])
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #127): current locale settings:
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #128): locale.get_locale(): (None, None)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_NUMERIC): (None, None)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_MESSAGES): (None, None)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_MONETARY): (None, None)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_COLLATE): (None, None)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_CTYPE): (None, None)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_TIME): (None, None)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_NUMERIC): C)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_MESSAGES): C)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_MONETARY): C)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_COLLATE): C)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_CTYPE): C)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_ALL): C)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_TIME): C)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #136): locale.getdefaultlocale() - default (user) locale: ('en_CA', 'UTF8')
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #140): encoding sanity check (also check "locale.nl_langinfo(CODESET)" below):
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #145): sys.getdefaultencoding(): [ascii]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #146): locale.getpreferredencoding(): [ANSI_X3.4-1968]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #147): locale.getlocale()[1]: [None]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #148): sys.getfilesystemencoding(): [UTF-8]
2010-01-10 16:35:01  WARNING   gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #155): encoding suggested by locale (ANSI_X3.4-1968) does not match encoding currently set in locale (None)
2010-01-10 16:35:01  WARNING   gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #156): this might lead to encoding errors
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #161): <codecs> module CAN handle encoding [ANSI_X3.4-1968]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #161): <codecs> module CAN handle encoding [ascii]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #161): <codecs> module CAN handle encoding [UTF-8]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #164): on Linux you can determine a likely candidate for the encoding by running "locale charmap"
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #166): locale related environment variables (${LANG} is typically used):
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #171): ${LANGUAGE} not set
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #171): ${LC_ALL} not set
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #171): ${LC_CTYPE} not set
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #169): ${LANG}=en_CA.UTF-8
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #173): database of locale conventions:
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(mon_decimal_point): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(int_frac_digits): 127
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(p_sep_by_space): 127
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(frac_digits): 127
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(thousands_sep): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(n_sign_posn): 127
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(decimal_point): .
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(int_curr_symbol): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(n_cs_precedes): 127
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(p_sign_posn): 127
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(mon_thousands_sep): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(negative_sign): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(currency_symbol): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(n_sep_by_space): 127
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(mon_grouping): []
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(p_cs_precedes): 127
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(positive_sign): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #177): locale.localeconv(grouping): []
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(D_FMT): %m/%d/%y
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(D_T_FMT): %a %b %e %H:%M:%S %Y
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(YESEXPR): ^[yY]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(ALT_DIGITS): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(T_FMT_AMPM): %I:%M:%S %p
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(RADIXCHAR): .
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(ERA_D_FMT): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(T_FMT): %H:%M:%S
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(NOEXPR): ^[nN]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(CRNCYSTR): -
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(ERA): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(CODESET): ANSI_X3.4-1968
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(THOUSEP): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #192): locale.nl_langinfo(ERA_D_T_FMT): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::activate_locale() #230): activating user-default locale with <locale.setlocale(locale.LC_ALL, '')> returns: [en_CA.UTF-8]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #125): locale settings after activating user-default locale
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #127): current locale settings:
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #128): locale.get_locale(): ('en_CA', 'UTF8')
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_NUMERIC): ('en_CA', 'UTF8')
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_MESSAGES): ('en_CA', 'UTF8')
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_MONETARY): ('en_CA', 'UTF8')
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_COLLATE): ('en_CA', 'UTF8')
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_CTYPE): ('en_CA', 'UTF8')
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #130): locale.get_locale(LC_TIME): ('en_CA', 'UTF8')
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_NUMERIC): en_CA.UTF-8)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_MESSAGES): en_CA.UTF-8)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_MONETARY): en_CA.UTF-8)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_COLLATE): en_CA.UTF-8)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_CTYPE): en_CA.UTF-8)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_ALL): en_CA.UTF-8)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #133): (locale.set_locale(LC_TIME): en_CA.UTF-8)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #136): locale.getdefaultlocale() - default (user) locale: ('en_CA', 'UTF8')
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #140): encoding sanity check (also check "locale.nl_langinfo(CODESET)" below):
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #145): sys.getdefaultencoding(): [ascii]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #146): locale.getpreferredencoding(): [UTF-8]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #147): locale.getlocale()[1]: [UTF8]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #148): sys.getfilesystemencoding(): [UTF-8]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #161): <codecs> module CAN handle encoding [UTF-8]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #161): <codecs> module CAN handle encoding [UTF8]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #161): <codecs> module CAN handle encoding [ascii]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #161): <codecs> module CAN handle encoding [UTF-8]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #164): on Linux you can determine a likely candidate for the encoding by running "locale charmap"
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #166): locale related environment variables (${LANG} is typically used):
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #171): ${LANGUAGE} not set
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #171): ${LC_ALL} not set
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #171): ${LC_CTYPE} not set
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #169): ${LANG}=en_CA.UTF-8
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #173): database of locale conventions:
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(mon_decimal_point): .
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(int_frac_digits): 2
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(p_sep_by_space): 0
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(frac_digits): 2
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(thousands_sep): ,
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(n_sign_posn): 1
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(decimal_point): .
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(int_curr_symbol): CAD 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(n_cs_precedes): 1
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(p_sign_posn): 1
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(mon_thousands_sep): ,
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(negative_sign): -
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(currency_symbol): $
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(n_sep_by_space): 0
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(mon_grouping): [3, 3, 0]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(p_cs_precedes): 1
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(positive_sign): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #180): locale.localeconv(grouping): [3, 3, 0]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(D_FMT): %y-%m-%d
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(D_T_FMT): %a %d %b %Y %r %Z
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(YESEXPR): ^[yYoO].*
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(ALT_DIGITS): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(T_FMT_AMPM): %I:%M:%S %p
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(RADIXCHAR): .
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(ERA_D_FMT): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(T_FMT): %r
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(NOEXPR): ^[nN].*
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(CRNCYSTR): -$
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(ERA): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(CODESET): UTF-8
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(THOUSEP): ,
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__log_locale_settings() #195): locale.nl_langinfo(ERA_D_T_FMT): 
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__split_locale_into_levels() #98): splitting canonical locale [en_CA] into levels
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::__split_locale_into_levels() #107): system locale levels: {'country': 'en_CA', 'full': 'en_CA', 'language': 'en'}
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [--text-domain] not in group [cli] in source [cli]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [--lang-gettext] not in group [cli] in source [cli]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::local-import] found in source [internal]
2010-01-10 16:35:01  INFO      gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #261): text domain is [gnumed]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #264): searching message catalog file for system locale [en_CA]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #270): ${LANGUAGE} = [None]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #270): ${LC_ALL} = [None]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #270): ${LC_MESSAGES} = [None]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #270): ${LANG} = [en_CA.UTF-8]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #281): preferring local message catalog
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #287): looking above binary install directory [/home/jbusser/gm/rc4/client/locale]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #291): looking in binary install directory [/home/jbusser/gm/rc4/client/wxpython/locale]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #295): system is POSIX, looking in standard locations (see Python Manual)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #303): looking at ${GNUMED_DIR}
2010-01-10 16:35:01  INFO      gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #309): ${GNUMED_DIR} not set
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #326): trying [/home/jbusser/gm/rc4/client/locale](/en_CA/LC_MESSAGES/gnumed.mo)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #337): does not translate: [Translate this or i18n will not work properly !] => [Translate this or i18n will not work properly !]
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #326): trying [/home/jbusser/gm/rc4/client/wxpython/locale](/en_CA/LC_MESSAGES/gnumed.mo)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #326): trying [/usr/share/locale](/en_CA/LC_MESSAGES/gnumed.mo)
2010-01-10 16:35:01  DEBUG     gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #337): does not translate: [Translate this or i18n will not work properly !] => [Translate this or i18n will not work properly !]
2010-01-10 16:35:01  WARNING   gm.i18n (/home/jbusser/gm/rc4/Gnumed/pycommon/gmI18N.py::install_domain() #348): falling back to NullTranslations() class
2010-01-10 16:35:01  INFO      gm.logging (/home/jbusser/gm/rc4/Gnumed/pycommon/gmLog2.py::set_string_encoding() #195): setting python.str -> python.unicode encoding to <UTF8> (locale.getlocale)
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [--help] not in group [cli] in source [cli]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [-h] not in group [cli] in source [cli]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [-?] not in group [cli] in source [cli]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [--version] not in group [cli] in source [cli]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [-V] not in group [cli] in source [cli]
2010-01-10 16:35:01  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::init_paths() #261): wxPython not available
2010-01-10 16:35:01  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::init_paths() #262): detecting paths directly
2010-01-10 16:35:01  INFO      gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::init_paths() #268): app name passed in as [gnumed]
2010-01-10 16:35:01  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #337): sys.argv[0]: wxpython/gnumed.py
2010-01-10 16:35:01  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #338): local application base dir: /home/jbusser/gm/rc4/client
2010-01-10 16:35:01  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #339): current working dir: /home/jbusser/gm/rc4/client
2010-01-10 16:35:01  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #341): user home dir: /home/jbusser
2010-01-10 16:35:01  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #342): user-specific config dir: /home/jbusser/.gnumed
2010-01-10 16:35:01  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #343): system-wide config dir: /etc/gnumed
2010-01-10 16:35:01  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #344): system-wide application data dir: /usr/share/gnumed
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #122): mx.DateTime.now(): [2010-01-10 16:35:01.59]
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #123): datetime.now()   : [2010-01-10 16:35:01.599030]
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #124): time.localtime() : [time.struct_time(tm_year=2010, tm_mon=1, tm_mday=10, tm_hour=16, tm_min=35, tm_sec=1, tm_wday=6, tm_yday=10, tm_isdst=0)]
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #125): time.gmtime()    : [time.struct_time(tm_year=2010, tm_mon=1, tm_mday=11, tm_hour=0, tm_min=35, tm_sec=1, tm_wday=0, tm_yday=11, tm_isdst=0)]
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #130): $TZ not defined
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #132): time.daylight: [1] (whether or not DST is locally used at all)
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #133): time.timezone: [28800] seconds
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #134): time.altzone : [25200] seconds
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #135): time.tzname  : [PST / PDT] (non-DST / DST)
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #136): mx.DateTime.now().gmtoffset(): [-08:00:00.00]
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #149): DST currently in effect: [False]
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #161): DST currently not in effect: using UTC offset of [-28800] seconds instead of [-25200] seconds
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #166): UTC offset is negative, assuming WEST of Greenwich (clock is "behind")
2010-01-10 16:35:01  DEBUG     gm.datetime (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDateTime.py::init() #172): ISO timezone: [-08:00:00.00] (taken from mx.DateTime.now().gmtoffset())
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [cli::--conf-file] found in source [cli]
2010-01-10 16:35:01  INFO      gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_file_source() #368): file source "workbase": /home/jbusser/gm/rc4/client/gnumed.conf (UTF8)
2010-01-10 16:35:01  ERROR     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_file_source() #381): cannot open [/home/jbusser/gm/rc4/client/gnumed.conf], keeping as dummy source
2010-01-10 16:35:01  INFO      gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_file_source() #368): file source "system": /etc/gnumed/gnumed-client.conf (UTF8)
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::parse_INI_stream() #197): parsing INI-style data stream [<open file u'/etc/gnumed/gnumed-client.conf', mode 'rUb' at 0x1382ad0>]
2010-01-10 16:35:01  INFO      gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_file_source() #368): file source "user": /home/jbusser/.gnumed/gnumed.conf (UTF8)
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::parse_INI_stream() #197): parsing INI-style data stream [<open file u'/home/jbusser/.gnumed/gnumed.conf', mode 'rUb' at 0x1382ad0>]
2010-01-10 16:35:01  INFO      gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_file_source() #368): file source "local": /home/jbusser/gm/rc4/client/gnumed.conf (UTF8)
2010-01-10 16:35:01  ERROR     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_file_source() #381): cannot open [/home/jbusser/gm/rc4/client/gnumed.conf], keeping as dummy source
2010-01-10 16:35:01  INFO      gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_file_source() #368): file source "explicit": gm-from-cvs.conf (UTF8)
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::parse_INI_stream() #197): parsing INI-style data stream [<open file 'gm-from-cvs.conf', mode 'rUb' at 0x1382ad0>]
2010-01-10 16:35:01  INFO      gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_file_source() #368): file source "user-mime": /home/jbusser/.gnumed/mime_type2file_extension.conf (UTF8)
2010-01-10 16:35:01  ERROR     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_file_source() #381): cannot open [/home/jbusser/.gnumed/mime_type2file_extension.conf], keeping as dummy source
2010-01-10 16:35:01  INFO      gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::add_file_source() #368): file source "system-mime": /etc/gnumed/mime_type2file_extension.conf (UTF8)
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::parse_INI_stream() #197): parsing INI-style data stream [<open file u'/etc/gnumed/mime_type2file_extension.conf', mode 'rUb' at 0x1382ad0>]
2010-01-10 16:35:01  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmLoginInfo.py::<module>() #13): $Revision: 1.17 $
2010-01-10 16:35:01  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::<module>() #29): $Revision: 1.123 $
2010-01-10 16:35:01  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::<module>() #41): psycopg2 version: 2.0.8 (dec mx dt ext pq3)
2010-01-10 16:35:01  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::<module>() #42): PostgreSQL via DB-API module "<module 'psycopg2' from '/usr/lib/python2.6/dist-packages/psycopg2/__init__.pyc'>": API level 2.0, thread safety 2, parameter style "pyformat"
2010-01-10 16:35:01  DEBUG     psycopg2 (/usr/lib/python2.6/dist-packages/psycopg2/pool.py::<module>() #34): installed. Logging using Python logging module
2010-01-10 16:35:01  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::<module>() #69): assuming default client encoding of [UTF8]
2010-01-10 16:35:01  INFO      gm.launcher (wxpython/gnumed.py::setup_backend() #409): client expects database version [v12]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [client timezone] not in group [backend] in source [explicit]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [client timezone] not in group [backend] in source [workbase]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [client timezone] not in group [backend] in source [local]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [client timezone] not in group [backend] in source [user]
2010-01-10 16:35:01  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [client timezone] not in group [backend] in source [system]
2010-01-10 16:35:01  INFO      gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::import_module_from_directory() #577): appending to sys.path: [/home/jbusser/.gnumed/scripts]
2010-01-10 16:35:01  INFO      gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::import_module_from_directory() #593): imported module [hook_script] as [<module 'hook_script' from '/home/jbusser/.gnumed/scripts/hook_script.pyc'>]
2010-01-10 16:35:01  INFO      gm.hook (/home/jbusser/gm/rc4/Gnumed/pycommon/gmHooks.py::import_hook_module() #135): hook script: /home/jbusser/.gnumed/scripts/hook_script.py
2010-01-10 16:35:02  INFO      gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg.py::<module>() #40): $Revision: 1.60 $
2010-01-10 16:35:02  INFO      gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::<module>() #16): $Revision: 1.12 $
2010-01-10 16:35:02  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::<module>() #20): $Revision: 1.22 $
2010-01-10 16:35:02  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBusinessDBObject.py::<module>() #143): $Revision: 1.60 $
2010-01-10 16:35:02  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/pycommon/gmMatchProvider.py::<module>() #24): $Revision: 1.34 $
2010-01-10 16:35:02  INFO      gm.docs (/home/jbusser/gm/rc4/Gnumed/pycommon/gmMimeLib.py::<module>() #23): $Revision: 1.27 $
2010-01-10 16:35:02  INFO      gm.docs (/home/jbusser/gm/rc4/Gnumed/business/gmMedDoc.py::<module>() #21): $Revision: 1.118 $
2010-01-10 16:35:02  INFO      gm.business (/home/jbusser/gm/rc4/Gnumed/business/gmDemographicRecord.py::<module>() #30): $Revision: 1.103 $
2010-01-10 16:35:02  INFO      gm.domain (/home/jbusser/gm/rc4/Gnumed/business/gmAllergy.py::<module>() #19): $Revision: 1.34 $
2010-01-10 16:35:02  INFO      gm.emr (/home/jbusser/gm/rc4/Gnumed/business/gmClinNarrative.py::<module>() #22): $Revision: 1.44 $
2010-01-10 16:35:02  INFO      gm.emr (/home/jbusser/gm/rc4/Gnumed/business/gmEMRStructItems.py::<module>() #20): $Revision: 1.156 $
2010-01-10 16:35:02  INFO      gm.lab (/home/jbusser/gm/rc4/Gnumed/business/gmPathLab.py::<module>() #22): $Revision: 1.79 $
2010-01-10 16:35:02  INFO      gm.atc (/home/jbusser/gm/rc4/Gnumed/business/gmATC.py::<module>() #23): $Revision: 1.6 $
2010-01-10 16:35:02  INFO      gm.meds (/home/jbusser/gm/rc4/Gnumed/business/gmMedication.py::<module>() #22): $Revision: 1.20 $
2010-01-10 16:35:02  DEBUG     gm.emr (/home/jbusser/gm/rc4/Gnumed/business/gmClinicalRecord.py::<module>() #49): $Revision: 1.308 $
2010-01-10 16:35:02  INFO      gm.person (/home/jbusser/gm/rc4/Gnumed/business/gmPerson.py::<module>() #26): $Revision: 1.196 $
2010-01-10 16:35:03  INFO      gm.export (/home/jbusser/gm/rc4/Gnumed/exporters/gmPatientExporter.py::<module>() #32): $Revision: 1.138 $
2010-01-10 16:35:03  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::<module>() #24): $Revision: 1.85 $
2010-01-10 16:35:03  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPatPicWidgets.py::<module>() #27): $Revision: 1.33 $
2010-01-10 16:35:03  INFO      gm.kvk (/home/jbusser/gm/rc4/Gnumed/business/gmKVK.py::<module>() #29): $Revision: 1.22 $
2010-01-10 16:35:03  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmDataMiningWidgets.py::<module>() #29): $Revision: 1.14 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmEditArea.py::<module>() #22): $Revision: 1.134 $
2010-01-10 16:35:04  INFO      gm.gui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmExceptionHandlingWidgets.py::<module>() #22): $Revision: 1.16 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmAuthWidgets.py::<module>() #31): $Revision: 1.45 $
2010-01-10 16:35:04  INFO      gm.person (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPatSearchWidgets.py::<module>() #34): $Revision: 1.130 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmAllergyWidgets.py::<module>() #23): $Revision: 1.35 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmTopPanel.py::<module>() #22): $Revision: 1.106 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::<module>() #34): $Revision: 1.47 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmEMRStructWidgets.py::<module>() #39): $Revision: 1.112 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmResizingWidgets.py::<module>() #23): $Revision: 1.55 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmSOAPWidgets.py::<module>() #24): $Revision: 1.113 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmNarrativeWidgets.py::<module>() #25): $Revision: 1.44 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmEMRBrowser.py::<module>() #24): $Revision: 1.110 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmStaffWidgets.py::<module>() #25): $Revision: 1.26 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMedDocWidgets.py::<module>() #24): $Revision: 1.186 $
2010-01-10 16:35:04  INFO      gm.printing (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPrinting.py::<module>() #25): $Revision: 1.4 $
2010-01-10 16:35:04  INFO      gm.forms (/home/jbusser/gm/rc4/Gnumed/business/gmForms.py::<module>() #28): $Revision: 1.74 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmFormWidgets.py::<module>() #24): $Revision: 1.16 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmProviderInboxWidgets.py::<module>() #24): $Revision: 1.46 $
2010-01-10 16:35:04  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmCfgWidgets.py::<module>() #27): $Revision: 1.4 $
2010-01-10 16:35:05  INFO      gm.loinc (/home/jbusser/gm/rc4/Gnumed/business/gmLOINC.py::<module>() #23): $Revision: 1.7 $
2010-01-10 16:35:05  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMeasurementWidgets.py::<module>() #27): $Revision: 1.64 $
2010-01-10 16:35:05  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMedicationWidgets.py::<module>() #25): $Revision: 1.31 $
2010-01-10 16:35:05  INFO      gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::<module>() #73): $Revision: 1.485 $
2010-01-10 16:35:05  INFO      gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::<module>() #74): wxPython GUI framework: 2.8.10.1 ('__WXGTK__', 'wxGTK', 'unicode', 'gtk2', 'wx-assertions-off', 'SWIG-1.3.29')
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [--profile] not in group [cli] in source [cli]
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::debug] found in source [internal]
2010-01-10 16:35:05  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::main() #2894): gmDispatcher signal monitor activated
2010-01-10 16:35:05  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::main() #2899): wx.lib.pubsub signal monitor activated
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [workplace::help desk] found in source [explicit]
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::client_version] found in source [internal]
2010-01-10 16:35:05  INFO      gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::OnInit() #2371): display: 1276:669
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::init_paths() #262): detecting paths directly
2010-01-10 16:35:05  INFO      gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::init_paths() #268): app name passed in as [gnumed]
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #337): sys.argv[0]: wxpython/gnumed.py
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #338): local application base dir: /home/jbusser/gm/rc4/client
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #339): current working dir: /home/jbusser/gm/rc4/client
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #341): user home dir: /home/jbusser
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #342): user-specific config dir: /home/jbusser/.gnumed
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #343): system-wide config dir: /etc/gnumed
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #344): system-wide application data dir: /usr/share/gnumed
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::init_paths() #303): re-detecting paths with wxPython
2010-01-10 16:35:05  INFO      gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::init_paths() #306): wxPython app name is [gnumed]
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #337): sys.argv[0]: wxpython/gnumed.py
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #338): local application base dir: /home/jbusser/gm/rc4/client
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #339): current working dir: /home/jbusser/gm/rc4/client
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #341): user home dir: /home/jbusser
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #342): user-specific config dir: /home/jbusser/.gnumed
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #343): system-wide config dir: /etc/gnumed
2010-01-10 16:35:05  DEBUG     gm.tools (/home/jbusser/gm/rc4/Gnumed/pycommon/gmTools.py::__log_paths() #344): system-wide application data dir: /usr/share/gnumed
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [cli::--conf-file] found in source [cli]
2010-01-10 16:35:05  INFO      gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::__setup_prefs_file() #2672): user preferences file: gm-from-cvs.conf
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [user email] not in group [preferences] in source [explicit]
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [user email] not in group [preferences] in source [user]
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [user email] not in group [preferences] in source [local]
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [user email] not in group [preferences] in source [workbase]
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [user email] not in group [preferences] in source [system]
2010-01-10 16:35:05  INFO      gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::__setup_platform() #2747): running on GTK (probably Linux)
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [cli::--override-schema-check] found in source [cli]
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::client_branch] found in source [internal]
2010-01-10 16:35:05  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::client_version] found in source [internal]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [name] not in group [workplace] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [name] not in group [workplace] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [name] not in group [workplace] in source [local]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [name] not in group [workplace] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [workplace::name] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [backend::profiles] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [backend::profiles] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [profiles] not in group [backend] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [profiles] not in group [backend] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database on this machine (Linux/Mac)::host] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database on this machine (Linux/Mac)::port] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database on this machine (Linux/Mac)::database] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database on this machine (Linux/Mac)] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database on this machine (Linux/Mac)] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database on this machine (Linux/Mac)] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database on this machine (Linux/Mac)] in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database on this machine (Linux/Mac)::public/open access] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database on this machine (Linux/Mac)::help desk] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database on this machine (Windows)::host] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database on this machine (Windows)::port] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database on this machine (Windows)::database] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database on this machine (Windows)] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database on this machine (Windows)] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database on this machine (Windows)] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database on this machine (Windows)] in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database on this machine (Windows)::public/open access] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database on this machine (Windows)::help desk] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database at salaam.homeunix.com::host] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database at salaam.homeunix.com::port] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database at salaam.homeunix.com::database] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database at salaam.homeunix.com] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database at salaam.homeunix.com] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database at salaam.homeunix.com] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile GNUmed database at salaam.homeunix.com] in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database at salaam.homeunix.com::public/open access] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile GNUmed database at salaam.homeunix.com::help desk] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [host] not in group [profile public GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [host] not in group [profile public GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [host] not in group [profile public GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile public GNUmed database::host] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [port] not in group [profile public GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [port] not in group [profile public GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [port] not in group [profile public GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile public GNUmed database::port] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [database] not in group [profile public GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [database] not in group [profile public GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [database] not in group [profile public GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile public GNUmed database::database] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile public GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile public GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile public GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile public GNUmed database] in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [public/open access] not in group [profile public GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [public/open access] not in group [profile public GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [public/open access] not in group [profile public GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile public GNUmed database::public/open access] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [help desk] not in group [profile public GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [help desk] not in group [profile public GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [help desk] not in group [profile public GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile public GNUmed database::help desk] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [host] not in group [profile local GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [host] not in group [profile local GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [host] not in group [profile local GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile local GNUmed database::host] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [port] not in group [profile local GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [port] not in group [profile local GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [port] not in group [profile local GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile local GNUmed database::port] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [database] not in group [profile local GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [database] not in group [profile local GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [database] not in group [profile local GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile local GNUmed database::database] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile local GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile local GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile local GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [encoding] not in group [profile local GNUmed database] in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [public/open access] not in group [profile local GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [public/open access] not in group [profile local GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [public/open access] not in group [profile local GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [public/open access] not in group [profile local GNUmed database] in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [help desk] not in group [profile local GNUmed database] in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [help desk] not in group [profile local GNUmed database] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [help desk] not in group [profile local GNUmed database] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [profile local GNUmed database::help desk] found in source [system]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::debug] found in source [internal]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [backend::logins] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [logins] not in group [backend] in source [user]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [logins] not in group [backend] in source [workbase]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [preferences::login] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [preferences::profile] found in source [explicit]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::debug] found in source [internal]
2010-01-10 16:35:06  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::slave] found in source [internal]
2010-01-10 16:35:06  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmAuthWidgets.py::connect_to_database() #120): login attempt 1 of 3
2010-01-10 16:35:13  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmAuthWidgets.py::__on_login_button_pressed() #674): debug mode enabled
2010-01-10 16:35:13  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmAuthWidgets.py::__on_login_button_pressed() #689): slave mode disabled
2010-01-10 16:35:13  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmAuthWidgets.py::GetLoginInfo() #622): backend profile "GNUmed database at salaam.homeunix.com" selected
2010-01-10 16:35:13  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmAuthWidgets.py::GetLoginInfo() #629):  details: <any-doc> on address@hidden:5432 (UTF8, public)
2010-01-10 16:35:13  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmAuthWidgets.py::GetLoginInfo() #631):  helpdesk: "GNUmed Development List <address@hidden>"
2010-01-10 16:35:17  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30335, readonly: True
2010-01-10 16:35:17  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1209): PostgreSQL version (numeric): 8.3
2010-01-10 16:35:17  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1212): database size: 28 MB
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [add_missing_from]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [allow_system_table_mods]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [archive_command]: (disabled)
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [archive_mode]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [archive_timeout]: 0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [array_nulls]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [authentication_timeout]: 1min
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [autovacuum]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [autovacuum_analyze_scale_factor]: 0.1
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [autovacuum_analyze_threshold]: 50
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [autovacuum_freeze_max_age]: 200000000
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [autovacuum_max_workers]: 3
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [autovacuum_naptime]: 1min
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [autovacuum_vacuum_cost_delay]: 20ms
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [autovacuum_vacuum_cost_limit]: -1
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [autovacuum_vacuum_scale_factor]: 0.2
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [autovacuum_vacuum_threshold]: 50
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [backslash_quote]: safe_encoding
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [bgwriter_delay]: 200ms
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [bgwriter_lru_maxpages]: 100
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [bgwriter_lru_multiplier]: 2
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [block_size]: 8192
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [bonjour_name]: 
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [check_function_bodies]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [checkpoint_completion_target]: 0.5
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [checkpoint_segments]: 3
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [checkpoint_timeout]: 5min
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [checkpoint_warning]: 30s
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [client_encoding]: UTF8
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [client_min_messages]: notice
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [commit_delay]: 0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [commit_siblings]: 5
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [constraint_exclusion]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [cpu_index_tuple_cost]: 0.005
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [cpu_operator_cost]: 0.0025
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [cpu_tuple_cost]: 0.01
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [custom_variable_classes]: 
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [DateStyle]: ISO, MDY
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [db_user_namespace]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [deadlock_timeout]: 1s
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [debug_assertions]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [debug_pretty_print]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [debug_print_parse]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [debug_print_plan]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [debug_print_rewritten]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [default_statistics_target]: 10
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [default_tablespace]: 
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [default_text_search_config]: pg_catalog.simple
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [default_transaction_isolation]: read committed
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [default_transaction_read_only]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [default_with_oids]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [effective_cache_size]: 128MB
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [enable_bitmapscan]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [enable_hashagg]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [enable_hashjoin]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [enable_indexscan]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [enable_mergejoin]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [enable_nestloop]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [enable_seqscan]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [enable_sort]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [enable_tidscan]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [escape_string_warning]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [explain_pretty_print]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [extra_float_digits]: 0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [from_collapse_limit]: 8
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [fsync]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [full_page_writes]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [geqo]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [geqo_effort]: 5
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [geqo_generations]: 0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [geqo_pool_size]: 0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [geqo_selection_bias]: 2
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [geqo_threshold]: 12
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [gin_fuzzy_search_limit]: 0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [ignore_system_indexes]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [integer_datetimes]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [join_collapse_limit]: 8
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [krb_caseins_users]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [krb_server_hostname]: 
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [krb_srvname]: postgres
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [lc_collate]: en_US.UTF-8
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [lc_ctype]: en_US.UTF-8
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [lc_messages]: C
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [lc_monetary]: address@hidden
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [lc_numeric]: address@hidden
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [lc_time]: address@hidden
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [listen_addresses]: *
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [local_preload_libraries]: 
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_autovacuum_min_duration]: -1
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_checkpoints]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_connections]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_destination]: stderr
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_disconnections]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_duration]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_error_verbosity]: default
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_executor_stats]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_hostname]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_line_prefix]: %t 
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_lock_waits]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_min_duration_statement]: -1
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_min_error_statement]: error
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_min_messages]: notice
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_parser_stats]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_planner_stats]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_rotation_age]: 1d
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_rotation_size]: 10MB
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_statement]: none
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_statement_stats]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_temp_files]: -1
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_timezone]: localtime
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [log_truncate_on_rotation]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [logging_collector]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [maintenance_work_mem]: 16MB
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [max_connections]: 100
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [max_files_per_process]: 1000
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [max_fsm_pages]: 20000
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [max_fsm_relations]: 1000
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [max_function_args]: 100
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [max_identifier_length]: 63
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [max_index_keys]: 32
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [max_locks_per_transaction]: 64
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [max_prepared_transactions]: 5
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [max_stack_depth]: 2MB
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [password_encryption]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [port]: 5432
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [post_auth_delay]: 0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [pre_auth_delay]: 0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [random_page_cost]: 4
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [regex_flavor]: advanced
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [search_path]: "$user",public
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [seq_page_cost]: 1
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [server_encoding]: UTF8
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [server_version]: 8.3.7
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [server_version_num]: 80307
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [session_replication_role]: origin
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [shared_buffers]: 8000kB
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [silent_mode]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [sql_inheritance]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [ssl]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [standard_conforming_strings]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [statement_timeout]: 0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [superuser_reserved_connections]: 3
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [synchronize_seqscans]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [synchronous_commit]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [syslog_facility]: LOCAL0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [syslog_ident]: postgres
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [tcp_keepalives_count]: 9
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [tcp_keepalives_idle]: 7200
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [tcp_keepalives_interval]: 75
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [temp_buffers]: 1024
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [temp_tablespaces]: 
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [TimeZone]: localtime
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [timezone_abbreviations]: Default
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [trace_notify]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [trace_sort]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [track_activities]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [track_counts]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [transaction_isolation]: read committed
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [transaction_read_only]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [transform_null_equals]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [unix_socket_group]: 
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [unix_socket_permissions]: 511
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [update_process_title]: on
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [vacuum_cost_delay]: 0
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [vacuum_cost_limit]: 200
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [vacuum_cost_page_dirty]: 20
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [vacuum_cost_page_hit]: 1
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [vacuum_cost_page_miss]: 10
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [vacuum_freeze_min_age]: 100000000
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [wal_buffers]: 64kB
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [wal_sync_method]: fdatasync
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [wal_writer_delay]: 200ms
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [work_mem]: 1MB
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [xmlbinary]: base64
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [xmloption]: content
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__log_PG_settings() #1461): PG option [zero_damaged_pages]: off
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__detect_client_timezone() #260): trying to detect timezone from system
2010-01-10 16:35:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__expand_timezone() #241): [PST] maps to [America/Los_Angeles]
2010-01-10 16:35:19  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__detect_client_timezone() #277): candidates: [u'PST', u'America/Los_Angeles']
2010-01-10 16:35:19  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__validate_timezone() #187): validating time zone [PST]
2010-01-10 16:35:19  WARNING   gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__validate_timezone() #208): time zone [PST] is not settable
2010-01-10 16:35:19  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__validate_timezone() #187): validating time zone [America/Los_Angeles]
2010-01-10 16:35:20  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__validate_timezone() #197): time zone [America/Los_Angeles] is settable
2010-01-10 16:35:20  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__validate_timezone() #203): time zone [America/Los_Angeles] is usable
2010-01-10 16:35:20  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::__detect_client_timezone() #294): client system time zone detected as equivalent to [America/Los_Angeles]
2010-01-10 16:35:20  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1227): access mode [READ ONLY]
2010-01-10 16:35:21  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::set_default_login() #415): setting default login from [<Gnumed.pycommon.gmLoginInfo.LoginInfo instance at 0x26a14d0>] to [<Gnumed.pycommon.gmLoginInfo.LoginInfo instance at 0x26a14d0>]
2010-01-10 16:35:21  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::set_default_login() #421): setting default DSN from [dbname=gnumed_v12 host=salaam.homeunix.com port=5432 user=any-doc password=any-doc sslmode=prefer] to [dbname=gnumed_v12 host=salaam.homeunix.com port=5432 user=any-doc password=any-doc sslmode=prefer]
2010-01-10 16:35:21  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::set_default_client_encoding() #169): setting default client encoding from [UTF8] to [UTF8]
2010-01-10 16:35:23  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30338, readonly: True
2010-01-10 16:35:23  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1227): access mode [READ ONLY]
2010-01-10 16:35:24  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1280): client string encoding [UTF8]
2010-01-10 16:35:24  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1292): isolation level [read committed]
2010-01-10 16:35:24  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1300): time zone [America/Los_Angeles]
2010-01-10 16:35:24  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1306): datestyle [ISO]
2010-01-10 16:35:24  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1311): sql_inheritance [on]
2010-01-10 16:35:25  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1320): PostgreSQL version (string): "PostgreSQL 8.3.7 on i486-pc-linux-gnu, compiled by GCC gcc-4.3.real (Debian 4.3.2-1.1) 4.3.2"
2010-01-10 16:35:26  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::database_schema_compatible() #452): detected schema version [v12], hash [06183a6616db62257e22814007a8ed07]
2010-01-10 16:35:26  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::user_preferences_file] found in source [internal]
2010-01-10 16:35:26  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmAuthWidgets.py::save_state() #598): saving login preferences in [gm-from-cvs.conf]
2010-01-10 16:35:26  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::set_option_in_INI_file() #171): setting option "login" to "any-doc" in group [preferences]
2010-01-10 16:35:26  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::set_option_in_INI_file() #172): file: gm-from-cvs.conf (utf8)
2010-01-10 16:35:26  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::set_option_in_INI_file() #171): setting option "profile" to "GNUmed database at salaam.homeunix.com (address@hidden)" in group [preferences]
2010-01-10 16:35:26  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::set_option_in_INI_file() #172): file: gm-from-cvs.conf (utf8)
2010-01-10 16:35:26  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::debug] found in source [internal]
2010-01-10 16:35:26  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::sanity_check_time_skew() #1348): maximum skew tolerance (seconds): 600
2010-01-10 16:35:29  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30340, readonly: True
2010-01-10 16:35:29  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1227): access mode [READ ONLY]
2010-01-10 16:35:30  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::sanity_check_time_skew() #1364): server "now" (UTC): 2010-01-11 00:35:42.764023
2010-01-10 16:35:30  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::sanity_check_time_skew() #1365): client "now" (UTC): 2010-01-11 00:35:30.273173
2010-01-10 16:35:30  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::sanity_check_time_skew() #1366): wire roundtrip (seconds): 0.388345956802
2010-01-10 16:35:30  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::sanity_check_time_skew() #1377): client/server time skew: 0:00:12.490850
2010-01-10 16:35:30  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::sanity_check_database_settings() #1394): checking database settings
2010-01-10 16:35:30  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::hipaa] found in source [internal]
2010-01-10 16:35:31  WARNING   gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::sanity_check_database_settings() #1437): PG option [log_connections] set to [off], expected [on], risk: <non-compliance with HIPAA>
2010-01-10 16:35:31  WARNING   gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::sanity_check_database_settings() #1437): PG option [log_disconnections] set to [off], expected [on], risk: <non-compliance with HIPAA>
2010-01-10 16:35:31  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__init__() #38): starting backend notifications listener thread
2010-01-10 16:35:31  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__init__() #51): connection has backend PID [30335]
2010-01-10 16:35:31  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_interests() #126): configured patient specific notifications:
2010-01-10 16:35:31  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_interests() #127): [u'allg_mod_db', u'allg_state_mod_db', u'bill_item_mod_db', u'comm_channel_mod_db', u'doc_mod_db', u'encounter_mod_db', u'episode_mod_db', u'health_issue_mod_db', u'hospital_stay_mod_db', u'identity_mod_db', u'message_inbox_mod_db', u'name_mod_db', u'narrative_mod_db', u'procedure_mod_db', u'substance_intake_mod_db', u'test_result_mod_db', u'vacc_mod_db', u'waiting_list_mod_db']
2010-01-10 16:35:31  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_interests() #138): configured unspecific notifications:
2010-01-10 16:35:31  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_interests() #139): [u'active_substance_mod_db', u'branded_drug_mod_db', u'consumed_substance_mod_db', u'doc_page_mod_db', u'doc_type_mod_db', u'reviewed_test_results_mod_db', u'substance_in_brand_mod_db', u'waiting_list_generic_mod_db', u'db_maintenance_warning', u'db_maintenance_disconnect']
2010-01-10 16:35:31  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_unspecific_notifications() #180): starting to listen for [active_substance_mod_db:]
2010-01-10 16:35:31  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_unspecific_notifications() #180): starting to listen for [branded_drug_mod_db:]
2010-01-10 16:35:31  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_unspecific_notifications() #180): starting to listen for [consumed_substance_mod_db:]
2010-01-10 16:35:32  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_unspecific_notifications() #180): starting to listen for [doc_page_mod_db:]
2010-01-10 16:35:32  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_unspecific_notifications() #180): starting to listen for [doc_type_mod_db:]
2010-01-10 16:35:32  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_unspecific_notifications() #180): starting to listen for [reviewed_test_results_mod_db:]
2010-01-10 16:35:32  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_unspecific_notifications() #180): starting to listen for [substance_in_brand_mod_db:]
2010-01-10 16:35:32  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_unspecific_notifications() #180): starting to listen for [waiting_list_generic_mod_db:]
2010-01-10 16:35:32  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_unspecific_notifications() #180): starting to listen for [db_maintenance_warning:]
2010-01-10 16:35:33  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_unspecific_notifications() #180): starting to listen for [db_maintenance_disconnect:]
2010-01-10 16:35:33  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__start_thread() #211): starting listener thread
2010-01-10 16:35:38  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::__check_db_lang() #2771): current database locale: [en_GB]
2010-01-10 16:35:38  WARNING   gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::__check_db_lang() #2791): database locale [en_GB] does not match system locale [en_CA]
2010-01-10 16:35:38  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [ignored mismatching system locale] not in group [backend] in source [explicit]
2010-01-10 16:35:38  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [ignored mismatching system locale] not in group [backend] in source [local]
2010-01-10 16:35:38  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [ignored mismatching system locale] not in group [backend] in source [user]
2010-01-10 16:35:38  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #312): option [ignored mismatching system locale] not in group [backend] in source [system]
2010-01-10 16:35:38  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::user_preferences_file] found in source [internal]
2010-01-10 16:35:44  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30347, readonly: False
2010-01-10 16:35:44  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1233): access mode [READ WRITE]
2010-01-10 16:35:44  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1280): client string encoding [UTF8]
2010-01-10 16:35:44  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1295): isolation level [serializable]
2010-01-10 16:35:44  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1300): time zone [America/Los_Angeles]
2010-01-10 16:35:45  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1306): datestyle [ISO]
2010-01-10 16:35:45  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1311): sql_inheritance [on]
2010-01-10 16:35:46  ERROR     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::__check_db_lang() #2856): Cannot set database language to [en_CA].
2010-01-10 16:35:48  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30349, readonly: False
2010-01-10 16:35:48  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1233): access mode [READ WRITE]
2010-01-10 16:35:49  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1280): client string encoding [UTF8]
2010-01-10 16:35:49  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1295): isolation level [serializable]
2010-01-10 16:35:49  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1300): time zone [America/Los_Angeles]
2010-01-10 16:35:49  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1306): datestyle [ISO]
2010-01-10 16:35:50  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1311): sql_inheritance [on]
2010-01-10 16:35:51  ERROR     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::__check_db_lang() #2856): Cannot set database language to [en_CA].
2010-01-10 16:35:53  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30351, readonly: False
2010-01-10 16:35:53  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1233): access mode [READ WRITE]
2010-01-10 16:35:54  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1280): client string encoding [UTF8]
2010-01-10 16:35:54  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1295): isolation level [serializable]
2010-01-10 16:35:54  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1300): time zone [America/Los_Angeles]
2010-01-10 16:35:54  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1306): datestyle [ISO]
2010-01-10 16:35:54  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1311): sql_inheritance [on]
2010-01-10 16:35:55  ERROR     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::__check_db_lang() #2856): Cannot set database language to [en].
2010-01-10 16:35:55  INFO      gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::__check_db_lang() #2861): forcing database language to [en_CA]
2010-01-10 16:35:58  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30356, readonly: False
2010-01-10 16:35:58  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1233): access mode [READ WRITE]
2010-01-10 16:35:59  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1280): client string encoding [UTF8]
2010-01-10 16:35:59  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1295): isolation level [serializable]
2010-01-10 16:35:59  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1300): time zone [America/Los_Angeles]
2010-01-10 16:35:59  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1306): datestyle [ISO]
2010-01-10 16:35:59  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1311): sql_inheritance [on]
2010-01-10 16:36:00  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::skip-update-check] found in source [internal]
2010-01-10 16:36:00  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::slave] found in source [internal]
2010-01-10 16:36:00  INFO      gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::__init__() #103): workplace is >>>GNUmed Default<<<
2010-01-10 16:36:00  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::detect_external_binary() #20): detecting [aeskulap]
2010-01-10 16:36:00  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::detect_external_binary() #35): [which aeskulap] returned: /usr/bin/aeskulap
2010-01-10 16:36:00  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::debug] found in source [internal]
2010-01-10 16:36:02  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::slave] found in source [internal]
2010-01-10 16:36:04  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::slave] found in source [internal]
2010-01-10 16:36:06  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmProviderInboxPlugin
2010-01-10 16:36:06  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmProviderInboxPlugin] name: [Inbox]
2010-01-10 16:36:06  ERROR     gm.messaging (/home/jbusser/gm/rc4/Gnumed/pycommon/gmDispatcher.py::connect() #93): unknown signal [message_inbox_generic_mod_db]
2010-01-10 16:36:06  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:06  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: Provider &inbox
2010-01-10 16:36:06  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmProviderInboxPlugin
2010-01-10 16:36:06  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: office
2010-01-10 16:36:06  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: Provider &inbox
2010-01-10 16:36:06  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmWaitingListPlugin
2010-01-10 16:36:06  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmWaitingListPlugin] name: [Waiting list]
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: &Waiting list
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmWaitingListPlugin
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: office
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: &Waiting list
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gui/gmNotebookedPatientEditionPlugin.py::<module>() #32): $Revision: 1.15 $
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmNotebookedPatientEditionPlugin
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmNotebookedPatientEditionPlugin] name: [Demographics]
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: &Demographics
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmNotebookedPatientEditionPlugin
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: patient
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: &Demographics
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gui/gmEMRBrowserPlugin.py::<module>() #20): $Revision: 1.18 $
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmEMRBrowserPlugin
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmEMRBrowserPlugin] name: [EMR tree]
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: EMR &tree
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmEMRBrowserPlugin
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: emr_show
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: EMR &tree
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gui/gmSoapPlugin.py::<module>() #31): $Revision: 1.6 $
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmSoapPlugin
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmSoapPlugin] name: [Notes]
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: Notes
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmSoapPlugin
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: None
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: None
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gui/gmCurrentSubstancesPlugin.py::<module>() #18): $Revision: 1.3 $
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmCurrentSubstancesPlugin
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmCurrentSubstancesPlugin] name: [Medication]
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: Current &medication
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmCurrentSubstancesPlugin
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: emr
2010-01-10 16:36:07  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: Current &medication
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gui/gmMeasurementsGridPlugin.py::<module>() #18): $Revision: 1.3 $
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmMeasurementsGridPlugin
2010-01-10 16:36:07  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmMeasurementsGridPlugin] name: [Measurements]
2010-01-10 16:36:08  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:08  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: &Measurements overview
2010-01-10 16:36:08  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmMeasurementsGridPlugin
2010-01-10 16:36:08  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: emr
2010-01-10 16:36:08  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: &Measurements overview
2010-01-10 16:36:08  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gui/gmShowMedDocs.py::<module>() #25): $Revision: 1.77 $
2010-01-10 16:36:08  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmShowMedDocs
2010-01-10 16:36:08  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmShowMedDocs] name: [Documents]
2010-01-10 16:36:08  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:08  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: &Show archived documents
2010-01-10 16:36:08  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmShowMedDocs
2010-01-10 16:36:08  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: emr
2010-01-10 16:36:08  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: &Show archived documents
2010-01-10 16:36:08  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmScanIdxMedDocsPlugin
2010-01-10 16:36:08  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmScanIdxMedDocsPlugin] name: [Attach documents]
2010-01-10 16:36:09  INFO      gm.scanning (/home/jbusser/gm/rc4/Gnumed/pycommon/gmScanBackend.py::<module>() #26): $Revision: 1.56 $
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: &Attach documents
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmScanIdxMedDocsPlugin
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: emr
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: &Attach documents
2010-01-10 16:36:09  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmKOrganizerPlugin
2010-01-10 16:36:09  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::detect_external_binary() #20): detecting [konsolekalendar]
2010-01-10 16:36:09  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::detect_external_binary() #35): [which konsolekalendar] returned: /usr/bin/konsolekalendar
2010-01-10 16:36:09  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmKOrganizerPlugin] name: [Appointments]
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: &Appointments
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmKOrganizerPlugin
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: office
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: &Appointments
2010-01-10 16:36:09  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmDataMiningPlugin
2010-01-10 16:36:09  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmDataMiningPlugin] name: [Reports]
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: &Report Generator
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmDataMiningPlugin
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: tools
2010-01-10 16:36:09  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: &Report Generator
2010-01-10 16:36:09  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gui/gmNotebookedProgressNoteInputPlugin.py::<module>() #31): $Revision: 1.17 $
2010-01-10 16:36:09  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmNotebookedProgressNoteInputPlugin
2010-01-10 16:36:09  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmNotebookedProgressNoteInputPlugin] name: [Progress notes]
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: &Progress notes editor
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmNotebookedProgressNoteInputPlugin
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: emr
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: &Progress notes editor
2010-01-10 16:36:13  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gui/gmEMRJournalPlugin.py::<module>() #18): $Revision: 1.14 $
2010-01-10 16:36:13  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmEMRJournalPlugin
2010-01-10 16:36:13  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmEMRJournalPlugin] name: [EMR journal]
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: Chronological &journal
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmEMRJournalPlugin
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: emr_show
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: Chronological &journal
2010-01-10 16:36:13  INFO      gm.xdt (/home/jbusser/gm/rc4/Gnumed/business/gmXdtObjects.py::<module>() #26): $Revision: 1.33 $
2010-01-10 16:36:13  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gui/gmXdtViewer.py::<module>() #30): $Revision: 1.39 $
2010-01-10 16:36:13  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::instantiate_plugin() #301): gmXdtViewer
2010-01-10 16:36:13  INFO      gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPlugin.py::register() #85): set: [gui] class: [gmXdtViewer] name: [xDT viewer]
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #714): registering plugin with menu system
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #715):  generic name: &xDT viewer
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #716):  class name: gmXdtViewer
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #717):  specific menu: tools
2010-01-10 16:36:13  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_on_plugin_loaded() #718):  menu item: &xDT viewer
2010-01-10 16:36:15  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::__set_GUI_size() #162): setting GUI size to [1392:922]
2010-01-10 16:36:15  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::debug] found in source [internal]
2010-01-10 16:36:15  DEBUG     gm.timers (/home/jbusser/gm/rc4/Gnumed/wxpython/gmTimer.py::__init__() #57): setting up timer: cookie [46499600], delay 2000ms
2010-01-10 16:45:32  DEBUG     gm.person (/home/jbusser/gm/rc4/Gnumed/business/gmPerson.py::__init__() #1146): patient change [cNull instance] -> [12] requested
2010-01-10 16:45:34  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30664, readonly: False
2010-01-10 16:45:34  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1233): access mode [READ WRITE]
2010-01-10 16:45:35  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1280): client string encoding [UTF8]
2010-01-10 16:45:35  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1295): isolation level [serializable]
2010-01-10 16:45:35  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1300): time zone [America/Los_Angeles]
2010-01-10 16:45:35  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1306): datestyle [ISO]
2010-01-10 16:45:35  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1311): sql_inheritance [on]
2010-01-10 16:45:41  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30666, readonly: False
2010-01-10 16:45:41  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1233): access mode [READ WRITE]
2010-01-10 16:45:41  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1280): client string encoding [UTF8]
2010-01-10 16:45:41  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1295): isolation level [serializable]
2010-01-10 16:45:41  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1300): time zone [America/Los_Angeles]
2010-01-10 16:45:42  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1306): datestyle [ISO]
2010-01-10 16:45:42  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1311): sql_inheritance [on]
2010-01-10 16:45:45  DEBUG     gm.emr (/home/jbusser/gm/rc4/Gnumed/business/gmClinicalRecord.py::__activate_very_recent_encounter() #1456): no <very recent> encounter (younger than [1 hour 30 minutes]) found
2010-01-10 16:45:49  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #160): just before switching notebook tabs
2010-01-10 16:45:49  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #168): event.GetOldSelection()=-1* -> event.GetSelection()=0
2010-01-10 16:45:49  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #171): the following two should match but do not:
2010-01-10 16:45:49  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #172):  event.GetOldSelection(): -1
2010-01-10 16:45:49  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #173):  notebook.GetSelection(): 0
2010-01-10 16:45:49  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #214): just after switching notebook tabs
2010-01-10 16:45:49  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #220): event.GetOldSelection()=-1 -> event.GetSelection()=0*
2010-01-10 16:45:49  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #223): those two really *should* match:
2010-01-10 16:45:49  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #224):  wx.Notebook.GetSelection() (before switch) : 0
2010-01-10 16:45:49  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #225):  EVT_NOTEBOOK_PAGE_CHANGED.GetOldSelection(): -1
2010-01-10 16:47:13  DEBUG     gm.emr (/home/jbusser/gm/rc4/Gnumed/business/gmClinicalRecord.py::_set_current_encounter() #1402): first setting of active encounter in this clinical record instance
2010-01-10 16:47:13  DEBUG     gm.emr (/home/jbusser/gm/rc4/Gnumed/business/gmClinicalRecord.py::__activate_fairly_recent_encounter() #1543): "fairly recent" encounter [1730] found and re-activated
2010-01-10 16:47:15  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30710, readonly: False
2010-01-10 16:47:15  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1233): access mode [READ WRITE]
2010-01-10 16:47:16  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1280): client string encoding [UTF8]
2010-01-10 16:47:16  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1295): isolation level [serializable]
2010-01-10 16:47:16  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1300): time zone [America/Los_Angeles]
2010-01-10 16:47:16  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1306): datestyle [ISO]
2010-01-10 16:47:17  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1311): sql_inheritance [on]
2010-01-10 16:47:18  DEBUG     gm.emr (/home/jbusser/gm/rc4/Gnumed/business/gmClinicalRecord.py::__init__() #115): Instantiated clinical record for patient [12].
2010-01-10 16:47:18  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [allg_mod_db:12]
2010-01-10 16:47:19  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [allg_state_mod_db:12]
2010-01-10 16:47:20  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [bill_item_mod_db:12]
2010-01-10 16:47:20  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [comm_channel_mod_db:12]
2010-01-10 16:47:20  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [doc_mod_db:12]
2010-01-10 16:47:20  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [encounter_mod_db:12]
2010-01-10 16:47:20  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [episode_mod_db:12]
2010-01-10 16:47:21  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [health_issue_mod_db:12]
2010-01-10 16:47:21  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [hospital_stay_mod_db:12]
2010-01-10 16:47:21  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [identity_mod_db:12]
2010-01-10 16:47:21  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [message_inbox_mod_db:12]
2010-01-10 16:47:21  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [name_mod_db:12]
2010-01-10 16:47:22  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [narrative_mod_db:12]
2010-01-10 16:47:22  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [procedure_mod_db:12]
2010-01-10 16:47:22  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [substance_intake_mod_db:12]
2010-01-10 16:47:22  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [test_result_mod_db:12]
2010-01-10 16:47:22  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [vacc_mod_db:12]
2010-01-10 16:47:23  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__register_patient_notifications() #160): starting to listen for [waiting_list_mod_db:12]
2010-01-10 16:47:23  DEBUG     gm.docs (/home/jbusser/gm/rc4/Gnumed/business/gmMedDoc.py::__init__() #43): instantiated document folder for patient [12]
2010-01-10 16:47:27  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30723, readonly: True
2010-01-10 16:47:27  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1227): access mode [READ ONLY]
2010-01-10 16:47:28  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::bytea2file_object() #840): expecting bytea data of size: [1872] bytes
2010-01-10 16:47:28  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::bytea2file_object() #841): using chunk size of: [0] bytes
2010-01-10 16:47:28  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::bytea2file_object() #846): chunk size [0] bytes: retrieving all data at once
2010-01-10 16:47:28  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::bytea2file_object() #852): chunks to retrieve: [1]
2010-01-10 16:47:28  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::bytea2file_object() #853): remainder to retrieve: [0] bytes
2010-01-10 16:47:30  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #160): just before switching notebook tabs
2010-01-10 16:47:30  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #168): event.GetOldSelection()=-1* -> event.GetSelection()=0
2010-01-10 16:47:30  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #171): the following two should match but do not:
2010-01-10 16:47:30  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #172):  event.GetOldSelection(): -1
2010-01-10 16:47:30  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #173):  notebook.GetSelection(): 0
2010-01-10 16:47:30  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #214): just after switching notebook tabs
2010-01-10 16:47:30  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #220): event.GetOldSelection()=-1 -> event.GetSelection()=0*
2010-01-10 16:47:30  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #223): those two really *should* match:
2010-01-10 16:47:30  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #224):  wx.Notebook.GetSelection() (before switch) : 0
2010-01-10 16:47:30  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #225):  EVT_NOTEBOOK_PAGE_CHANGED.GetOldSelection(): -1
2010-01-10 16:47:31  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #160): just before switching notebook tabs
2010-01-10 16:47:31  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #168): event.GetOldSelection()=0* -> event.GetSelection()=6
2010-01-10 16:47:31  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #214): just after switching notebook tabs
2010-01-10 16:47:31  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #220): event.GetOldSelection()=0 -> event.GetSelection()=6*
2010-01-10 16:47:41  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 30736, readonly: False
2010-01-10 16:47:41  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1233): access mode [READ WRITE]
2010-01-10 16:47:42  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1280): client string encoding [UTF8]
2010-01-10 16:47:42  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1295): isolation level [serializable]
2010-01-10 16:47:42  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1300): time zone [America/Los_Angeles]
2010-01-10 16:47:43  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1306): datestyle [ISO]
2010-01-10 16:47:43  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1311): sql_inheritance [on]
2010-01-10 16:47:45  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #160): just before switching notebook tabs
2010-01-10 16:47:45  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #168): event.GetOldSelection()=6* -> event.GetSelection()=7
2010-01-10 16:47:45  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #214): just after switching notebook tabs
2010-01-10 16:47:45  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #220): event.GetOldSelection()=6 -> event.GetSelection()=7*
2010-01-10 17:01:16  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #160): just before switching notebook tabs
2010-01-10 17:01:16  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #168): event.GetOldSelection()=7* -> event.GetSelection()=6
2010-01-10 17:01:16  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #214): just after switching notebook tabs
2010-01-10 17:01:16  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #220): event.GetOldSelection()=7 -> event.GetSelection()=6*
2010-01-10 17:01:24  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #160): just before switching notebook tabs
2010-01-10 17:01:24  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #168): event.GetOldSelection()=6* -> event.GetSelection()=5
2010-01-10 17:01:24  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #214): just after switching notebook tabs
2010-01-10 17:01:24  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #220): event.GetOldSelection()=6 -> event.GetSelection()=5*
2010-01-10 17:01:27  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::debug] found in source [internal]
2010-01-10 17:01:32  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 31116, readonly: True
2010-01-10 17:01:32  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1227): access mode [READ ONLY]
2010-01-10 17:01:33  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::bytea2file_object() #840): expecting bytea data of size: [2894] bytes
2010-01-10 17:01:33  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::bytea2file_object() #841): using chunk size of: [0] bytes
2010-01-10 17:01:33  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::bytea2file_object() #846): chunk size [0] bytes: retrieving all data at once
2010-01-10 17:01:33  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::bytea2file_object() #852): chunks to retrieve: [1]
2010-01-10 17:01:33  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::bytea2file_object() #853): remainder to retrieve: [0] bytes
2010-01-10 17:01:34  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<client_version>$]
2010-01-10 17:01:34  DEBUG     gm.cfg (/home/jbusser/gm/rc4/Gnumed/pycommon/gmCfg2.py::get() #314): option [internal::client_version] found in source [internal]
2010-01-10 17:01:34  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<today::%Y %B %d>$]
2010-01-10 17:01:34  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<current_provider>$]
2010-01-10 17:01:34  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<lastname>$]
2010-01-10 17:01:34  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<firstname>$]
2010-01-10 17:01:35  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<date_of_birth::%Y %B %d>$]
2010-01-10 17:01:35  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<adr_street::home>$]
2010-01-10 17:01:37  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<adr_number::home>$]
2010-01-10 17:01:38  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<adr_postcode::home>$]
2010-01-10 17:01:40  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<adr_location::home>$]
2010-01-10 17:01:41  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<current_meds::%(brand)s %(preparation)s & %(strength)s & %(schedule)s & {\footnotesize %(aim)s} \tabularnewline {\footnotesize (%(substance)s)} & \multicolumn{3}{l}{{\footnotesize %(notes)s}} \hfill \vline \tabularnewline \hline >$]
2010-01-10 17:01:42  DEBUG     gm.scripting (/home/jbusser/gm/rc4/Gnumed/wxpython/gmMacro.py::__getitem__() #105): replacing [$<allergies::%(descriptor)s & %(l10n_type)s & {\footnotesize %(reaction)s} \tabularnewline \hline >$]
2010-01-10 17:01:43  DEBUG     gm.forms (/home/jbusser/gm/rc4/Gnumed/business/gmForms.py::generate_output() #673): ignoring <format> directive [None], generating PDF
2010-01-10 17:01:43  DEBUG     gm.forms (/home/jbusser/gm/rc4/Gnumed/business/gmForms.py::generate_output() #677): LaTeX sandbox directory: [/home/jbusser/.gnumed/tmp/gm-L-Template-h9lDxV]
2010-01-10 17:01:43  DEBUG     gm.forms (/home/jbusser/gm/rc4/Gnumed/business/gmForms.py::generate_output() #680): CWD: [/home/jbusser/gm/rc4/client]
2010-01-10 17:01:43  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #91): shell command >>>pdflatex -interaction nonstopmode /home/jbusser/.gnumed/tmp/gm-L-Template-h9lDxV/gm-L-Template-h9lDxV-instance.tex<<<
2010-01-10 17:01:43  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #92): blocking: True
2010-01-10 17:01:43  INFO      gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #122): running shell command >>>pdflatex -interaction nonstopmode /home/jbusser/.gnumed/tmp/gm-L-Template-h9lDxV/gm-L-Template-h9lDxV-instance.tex<<<
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #124): os.system() returned: [0]
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #127): exited via exit(): True
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #129): exit code: [0]
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #131): normal exit: True
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #132): dumped core: False
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #133): stopped by signal: False
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #91): shell command >>>pdflatex -interaction nonstopmode /home/jbusser/.gnumed/tmp/gm-L-Template-h9lDxV/gm-L-Template-h9lDxV-instance.tex<<<
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #92): blocking: True
2010-01-10 17:01:57  INFO      gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #122): running shell command >>>pdflatex -interaction nonstopmode /home/jbusser/.gnumed/tmp/gm-L-Template-h9lDxV/gm-L-Template-h9lDxV-instance.tex<<<
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #124): os.system() returned: [0]
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #127): exited via exit(): True
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #129): exit code: [0]
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #131): normal exit: True
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #132): dumped core: False
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #133): stopped by signal: False
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #91): shell command >>>pdflatex -interaction nonstopmode /home/jbusser/.gnumed/tmp/gm-L-Template-h9lDxV/gm-L-Template-h9lDxV-instance.tex<<<
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #92): blocking: True
2010-01-10 17:01:57  INFO      gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #122): running shell command >>>pdflatex -interaction nonstopmode /home/jbusser/.gnumed/tmp/gm-L-Template-h9lDxV/gm-L-Template-h9lDxV-instance.tex<<<
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #124): os.system() returned: [0]
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #127): exited via exit(): True
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #129): exit code: [0]
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #131): normal exit: True
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #132): dumped core: False
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #133): stopped by signal: False
2010-01-10 17:01:57  DEBUG     gm.printing (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPrinting.py::print_file_by_shellscript() #36): printing "medication_list": [/home/jbusser/.gnumed/tmp/gm-L-Template-h9lDxV-instance.pdf]
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::detect_external_binary() #20): detecting [gm-print_doc]
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::detect_external_binary() #35): [which gm-print_doc] returned: /home/jbusser/bin/gm-print_doc
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #91): shell command >>>/home/jbusser/bin/gm-print_doc  medication_list /home/jbusser/.gnumed/tmp/gm-L-Template-h9lDxV-instance.pdf<<<
2010-01-10 17:01:57  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #92): blocking: False
2010-01-10 17:01:57  INFO      gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #122): running shell command >>>/home/jbusser/bin/gm-print_doc  medication_list /home/jbusser/.gnumed/tmp/gm-L-Template-h9lDxV-instance.pdf &<<<
2010-01-10 17:01:58  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #124): os.system() returned: [0]
2010-01-10 17:01:58  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #127): exited via exit(): True
2010-01-10 17:01:58  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #129): exit code: [0]
2010-01-10 17:01:58  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #131): normal exit: True
2010-01-10 17:01:58  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #132): dumped core: False
2010-01-10 17:01:58  DEBUG     gm.shell (/home/jbusser/gm/rc4/Gnumed/pycommon/gmShellAPI.py::run_command_in_shell() #133): stopped by signal: False
2010-01-10 17:02:01  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1196): new database connection, backend PID: 31131, readonly: False
2010-01-10 17:02:01  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_raw_connection() #1233): access mode [READ WRITE]
2010-01-10 17:02:02  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1280): client string encoding [UTF8]
2010-01-10 17:02:02  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1295): isolation level [serializable]
2010-01-10 17:02:02  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1300): time zone [America/Los_Angeles]
2010-01-10 17:02:02  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1306): datestyle [ISO]
2010-01-10 17:02:02  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmPG2.py::get_connection() #1311): sql_inheritance [on]
2010-01-10 17:05:21  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::OnClose() #1933): gmTopLevelFrame.OnClose() start
2010-01-10 17:05:21  DEBUG     gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_clean_exit() #2203): gmTopLevelFrame._clean_exit() start
2010-01-10 17:05:21  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::shutdown() #76): stopping backend notifications listener thread
2010-01-10 17:05:23  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [allg_mod_db:12]
2010-01-10 17:05:23  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [allg_state_mod_db:12]
2010-01-10 17:05:23  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [bill_item_mod_db:12]
2010-01-10 17:05:23  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [comm_channel_mod_db:12]
2010-01-10 17:05:23  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [doc_mod_db:12]
2010-01-10 17:05:24  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [encounter_mod_db:12]
2010-01-10 17:05:24  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [episode_mod_db:12]
2010-01-10 17:05:24  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [health_issue_mod_db:12]
2010-01-10 17:05:24  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [hospital_stay_mod_db:12]
2010-01-10 17:05:24  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [identity_mod_db:12]
2010-01-10 17:05:25  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [message_inbox_mod_db:12]
2010-01-10 17:05:25  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [name_mod_db:12]
2010-01-10 17:05:25  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [narrative_mod_db:12]
2010-01-10 17:05:25  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [procedure_mod_db:12]
2010-01-10 17:05:25  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [substance_intake_mod_db:12]
2010-01-10 17:05:26  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [test_result_mod_db:12]
2010-01-10 17:05:26  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [vacc_mod_db:12]
2010-01-10 17:05:26  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_patient_notifications() #171): stopping to listen for [waiting_list_mod_db:12]
2010-01-10 17:05:26  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_unspecific_notifications() #189): stopping to listen for [active_substance_mod_db:]
2010-01-10 17:05:26  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_unspecific_notifications() #189): stopping to listen for [branded_drug_mod_db:]
2010-01-10 17:05:27  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_unspecific_notifications() #189): stopping to listen for [consumed_substance_mod_db:]
2010-01-10 17:05:27  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_unspecific_notifications() #189): stopping to listen for [doc_page_mod_db:]
2010-01-10 17:05:27  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_unspecific_notifications() #189): stopping to listen for [doc_type_mod_db:]
2010-01-10 17:05:27  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_unspecific_notifications() #189): stopping to listen for [reviewed_test_results_mod_db:]
2010-01-10 17:05:27  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_unspecific_notifications() #189): stopping to listen for [substance_in_brand_mod_db:]
2010-01-10 17:05:28  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_unspecific_notifications() #189): stopping to listen for [waiting_list_generic_mod_db:]
2010-01-10 17:05:28  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_unspecific_notifications() #189): stopping to listen for [db_maintenance_warning:]
2010-01-10 17:05:28  INFO      gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__unregister_unspecific_notifications() #189): stopping to listen for [db_maintenance_disconnect:]
2010-01-10 17:05:28  DEBUG     gm.db (/home/jbusser/gm/rc4/Gnumed/pycommon/gmBackendListener.py::__shutdown_connection() #196): shutting down connection with backend PID [30335]
2010-01-10 17:05:28  INFO      gm.timers (/home/jbusser/gm/rc4/Gnumed/wxpython/gmTimer.py::shutdown() #24): shutting down 1 pending timers
2010-01-10 17:05:28  DEBUG     gm.timers (/home/jbusser/gm/rc4/Gnumed/wxpython/gmTimer.py::shutdown() #26): timer [46499600]
2010-01-10 17:05:28  INFO      macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #54): shutting down 10 pending timers
2010-01-10 17:05:28  DEBUG     macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #56): timer [<Gnumed.wxpython.gmPhraseWheel._cPRWTimer; proxy of <Swig Object of type 'wxPyTimer *' at 0x2b473b0> >]
2010-01-10 17:05:28  DEBUG     macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #56): timer [<Gnumed.wxpython.gmPhraseWheel._cPRWTimer; proxy of <Swig Object of type 'wxPyTimer *' at 0x2c6b800> >]
2010-01-10 17:05:28  DEBUG     macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #56): timer [<Gnumed.wxpython.gmPhraseWheel._cPRWTimer; proxy of <Swig Object of type 'wxPyTimer *' at 0x2c78400> >]
2010-01-10 17:05:28  DEBUG     macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #56): timer [<Gnumed.wxpython.gmPhraseWheel._cPRWTimer; proxy of <Swig Object of type 'wxPyTimer *' at 0x2c83fc0> >]
2010-01-10 17:05:28  DEBUG     macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #56): timer [<Gnumed.wxpython.gmPhraseWheel._cPRWTimer; proxy of <Swig Object of type 'wxPyTimer *' at 0x2d6cc10> >]
2010-01-10 17:05:28  DEBUG     macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #56): timer [<Gnumed.wxpython.gmPhraseWheel._cPRWTimer; proxy of <Swig Object of type 'wxPyTimer *' at 0x2d78c00> >]
2010-01-10 17:05:28  DEBUG     macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #56): timer [<Gnumed.wxpython.gmPhraseWheel._cPRWTimer; proxy of <Swig Object of type 'wxPyTimer *' at 0x2d86700> >]
2010-01-10 17:05:28  DEBUG     macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #56): timer [<Gnumed.wxpython.gmPhraseWheel._cPRWTimer; proxy of <Swig Object of type 'wxPyTimer *' at 0x2d91980> >]
2010-01-10 17:05:28  DEBUG     macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #56): timer [<Gnumed.wxpython.gmPhraseWheel._cPRWTimer; proxy of <Swig Object of type 'wxPyTimer *' at 0x2da0da0> >]
2010-01-10 17:05:28  DEBUG     macosx (/home/jbusser/gm/rc4/Gnumed/wxpython/gmPhraseWheel.py::shutdown() #56): timer [<Gnumed.wxpython.gmPhraseWheel._cPRWTimer; proxy of <Swig Object of type 'wxPyTimer *' at 0x2e02160> >]
2010-01-10 17:05:28  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #160): just before switching notebook tabs
2010-01-10 17:05:28  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #168): event.GetOldSelection()=-1* -> event.GetSelection()=0
2010-01-10 17:05:28  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #171): the following two should match but do not:
2010-01-10 17:05:28  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #172):  event.GetOldSelection(): -1
2010-01-10 17:05:28  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changing() #173):  notebook.GetSelection(): 5
2010-01-10 17:05:28  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #214): just after switching notebook tabs
2010-01-10 17:05:28  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #220): event.GetOldSelection()=-1 -> event.GetSelection()=0*
2010-01-10 17:05:28  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #223): those two really *should* match:
2010-01-10 17:05:28  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #224):  wx.Notebook.GetSelection() (before switch) : 5
2010-01-10 17:05:28  DEBUG     gm.ui (/home/jbusser/gm/rc4/Gnumed/wxpython/gmHorstSpace.py::_on_notebook_page_changed() #225):  EVT_NOTEBOOK_PAGE_CHANGED.GetOldSelection(): -1
2010-01-10 17:05:29  INFO      gm.main (/home/jbusser/gm/rc4/Gnumed/wxpython/gmGuiMain.py::_clean_exit() #2241): GUI size at shutdown: [1270:543]