GNU gdb (Ubuntu 7.10.1-0ubuntu1) 7.10.1 Copyright (C) 2015 Free Software Foundation, Inc. License GPLv3+: GNU GPL version 3 or later This is free software: you are free to change and redistribute it. There is NO WARRANTY, to the extent permitted by law. Type "show copying" and "show warranty" for details. This GDB was configured as "s390x-linux-gnu". Type "show configuration" for configuration details. For bug reporting instructions, please see: . Find the GDB manual and other documentation resources online at: . For help, type "help". Type "apropos word" to search for commands related to "word"... Reading symbols from /usr/sbin/rsyslogd...Reading symbols from /usr/lib/debug//usr/sbin/rsyslogd...done. done. (gdb) handle SIG33 pass nostop noprint Signal Stop Print Pass to program Description SIG33 No No Yes Real-time event 33 (gdb) set pagination 0 (gdb) run -dn Starting program: /usr/sbin/rsyslogd -dn [Thread debugging using libthread_db enabled] Using host libthread_db library "/lib/s390x-linux-gnu/libthread_db.so.1". 9055.767632727:main thread : rsyslogd 8.14.0 startup, module path '', cwd:/mnt 9055.767673736:main thread : caller requested object 'net', not found (iRet -3003) 9055.767678020:main thread : Requested to load module 'lmnet' 9055.767680433:main thread : loading module '/usr/lib/rsyslog/lmnet.so' 9055.770226477:main thread : module lmnet of type 2 being loaded (keepType=0). 9055.770236477:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.770237693:main thread : entry point 'setModCnf' not present in module 9055.770238764:main thread : entry point 'getModCnfName' not present in module 9055.770239746:main thread : entry point 'beginCnfLoad' not present in module 9055.770241507:main thread : source file conf.c requested reference for module 'lmnet', reference count now 1 9055.770250419:main thread : rsyslog runtime initialized, version 8.14.0, current users 1 9055.770276150:main thread : source file rsyslogd.c requested reference for module 'lmnet', reference count now 2 9055.772849291:main thread : GenerateLocalHostName uses 'devac03' 9055.772855545:main thread : deque option n, optarg '' 9055.772859504:main thread : omfile: using transactional output interface. 9055.772874153:main thread : module builtin:omfile of type 1 being loaded (keepType=0). 9055.772876353:main thread : module config name is 'omfile' 9055.772877602:main thread : module builtin:omfile supports rsyslog v6 config interface 9055.772880275:main thread : entry point 'activateCnfPrePrivDrop' not present in module 9055.772882916:main thread : entry point 'doHUPWrkr' not present in module 9055.772884131:main thread : entry point 'SetShutdownImmdtPtr' not present in module 9055.772885444:main thread : entry point 'doAction' not present in module 9055.772886840:main thread : entry point 'endTransaction' not present in module 9055.772889276:main thread : module builtin:ompipe of type 1 being loaded (keepType=0). 9055.772891180:main thread : module config name is 'ompipe' 9055.772892302:main thread : module builtin:ompipe supports rsyslog v6 config interface 9055.772894592:main thread : entry point 'activateCnfPrePrivDrop' not present in module 9055.772896918:main thread : entry point 'doHUPWrkr' not present in module 9055.772898139:main thread : entry point 'SetShutdownImmdtPtr' not present in module 9055.772899322:main thread : entry point 'beginTransaction' not present in module 9055.772900628:main thread : entry point 'commitTransaction' not present in module 9055.772901870:main thread : entry point 'endTransaction' not present in module 9055.772904307:main thread : module builtin-shell of type 1 being loaded (keepType=0). 9055.772905633:main thread : entry point 'setModCnf' not present in module 9055.772906704:main thread : entry point 'getModCnfName' not present in module 9055.772907800:main thread : entry point 'beginCnfLoad' not present in module 9055.772909744:main thread : entry point 'doHUP' not present in module 9055.772910795:main thread : entry point 'doHUPWrkr' not present in module 9055.772911894:main thread : entry point 'SetShutdownImmdtPtr' not present in module 9055.772912931:main thread : entry point 'beginTransaction' not present in module 9055.772914075:main thread : entry point 'commitTransaction' not present in module 9055.772915151:main thread : entry point 'endTransaction' not present in module 9055.772916193:main thread : entry point 'newActInst' not present in module 9055.772918076:main thread : module builtin:omdiscard of type 1 being loaded (keepType=0). 9055.772919433:main thread : entry point 'setModCnf' not present in module 9055.772920467:main thread : entry point 'getModCnfName' not present in module 9055.772921509:main thread : entry point 'beginCnfLoad' not present in module 9055.772923499:main thread : entry point 'doHUP' not present in module 9055.772924531:main thread : entry point 'doHUPWrkr' not present in module 9055.772925573:main thread : entry point 'SetShutdownImmdtPtr' not present in module 9055.772926665:main thread : entry point 'beginTransaction' not present in module 9055.772927801:main thread : entry point 'commitTransaction' not present in module 9055.772928826:main thread : entry point 'endTransaction' not present in module 9055.772929895:main thread : entry point 'newActInst' not present in module 9055.772932637:main thread : source file omfwd.c requested reference for module 'lmnet', reference count now 3 9055.772945276:main thread : module builtin:omfwd of type 1 being loaded (keepType=0). 9055.772947166:main thread : module config name is 'omfwd' 9055.772948297:main thread : module builtin:omfwd supports rsyslog v6 config interface 9055.772950557:main thread : entry point 'activateCnfPrePrivDrop' not present in module 9055.772952773:main thread : entry point 'doHUP' not present in module 9055.772953931:main thread : entry point 'doHUPWrkr' not present in module 9055.772955117:main thread : entry point 'SetShutdownImmdtPtr' not present in module 9055.772956701:main thread : entry point 'doAction' not present in module 9055.772958026:main thread : entry point 'endTransaction' not present in module 9055.772960207:main thread : module builtin:omusrmsg of type 1 being loaded (keepType=0). 9055.772961613:main thread : entry point 'setModCnf' not present in module 9055.772962795:main thread : module config name is 'omusrmsg' 9055.772963871:main thread : entry point 'beginCnfLoad' not present in module 9055.772965921:main thread : entry point 'doHUP' not present in module 9055.772966963:main thread : entry point 'doHUPWrkr' not present in module 9055.772968040:main thread : entry point 'SetShutdownImmdtPtr' not present in module 9055.772969142:main thread : entry point 'beginTransaction' not present in module 9055.772970317:main thread : entry point 'commitTransaction' not present in module 9055.772971380:main thread : entry point 'endTransaction' not present in module 9055.772974014:main thread : rfc5424 parser init called 9055.772975019:main thread : GetParserName addr 0x2aa00060690 9055.772976275:main thread : module builtin:pmrfc5424 of type 3 being loaded (keepType=0). 9055.772977459:main thread : entry point 'setModCnf' not present in module 9055.772978483:main thread : entry point 'getModCnfName' not present in module 9055.772979441:main thread : entry point 'beginCnfLoad' not present in module 9055.772980394:main thread : entry point 'parse2' not present in module 9055.772982267:main thread : DDDDD: added parser 'rsyslog.rfc5424' to list 0x2aa000a6e20 9055.772983257:main thread : Parser 'rsyslog.rfc5424' added to list of available parsers. 9055.772985322:main thread : rfc3164 parser init called 9055.772986682:main thread : module builtin:pmrfc3164 of type 3 being loaded (keepType=0). 9055.772987956:main thread : entry point 'setModCnf' not present in module 9055.772989051:main thread : module config name is 'pmrfc3164' 9055.772990107:main thread : entry point 'beginCnfLoad' not present in module 9055.772991428:main thread : newParserInst (pmrfc3164) 9055.772992738:main thread : DDDDD: added parser 'rsyslog.rfc3164' to list 0x2aa000a6e20 9055.772993701:main thread : Parser 'rsyslog.rfc3164' added to list of available parsers. 9055.772994854:main thread : DDDDD: added parser 'rsyslog.rfc5424' to list 0x2aa000a6e18 9055.772995771:main thread : Parser 'rsyslog.rfc5424' added to default parser set. 9055.772996861:main thread : DDDDD: added parser 'rsyslog.rfc3164' to list 0x2aa000a6e18 9055.772997739:main thread : Parser 'rsyslog.rfc3164' added to default parser set. 9055.772999948:main thread : rsyslog standard file format strgen init called, compiled with version 8.14.0 9055.773001316:main thread : module builtin:smfile of type 4 being loaded (keepType=0). 9055.773002364:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.773003312:main thread : entry point 'setModCnf' not present in module 9055.773004311:main thread : entry point 'getModCnfName' not present in module 9055.773005256:main thread : entry point 'beginCnfLoad' not present in module 9055.773007202:main thread : Strgen 'RSYSLOG_FileFormat' added to list of available strgens. 9055.773008464:main thread : traditional file format strgen init called, compiled with version 8.14.0 9055.773009681:main thread : module builtin:smtradfile of type 4 being loaded (keepType=0). 9055.773010767:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.773011729:main thread : entry point 'setModCnf' not present in module 9055.773012674:main thread : entry point 'getModCnfName' not present in module 9055.773013612:main thread : entry point 'beginCnfLoad' not present in module 9055.773014995:main thread : Strgen 'RSYSLOG_TraditionalFileFormat' added to list of available strgens. 9055.773016291:main thread : rsyslog standard (network) forward format strgen init called, compiled with version 8.14.0 9055.773017730:main thread : module builtin:smfwd of type 4 being loaded (keepType=0). 9055.773018778:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.773019747:main thread : entry point 'setModCnf' not present in module 9055.773020709:main thread : entry point 'getModCnfName' not present in module 9055.773021668:main thread : entry point 'beginCnfLoad' not present in module 9055.773022947:main thread : Strgen 'RSYSLOG_ForwardFormat' added to list of available strgens. 9055.773024180:main thread : rsyslog traditional (network) forward format strgen init called, compiled with version 8.14.0 9055.773025377:main thread : module builtin:smtradfwd of type 4 being loaded (keepType=0). 9055.773026431:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.773027387:main thread : entry point 'setModCnf' not present in module 9055.773028342:main thread : entry point 'getModCnfName' not present in module 9055.773029292:main thread : entry point 'beginCnfLoad' not present in module 9055.773030572:main thread : Strgen 'RSYSLOG_TraditionalForwardFormat' added to list of available strgens. 9055.773031610:main thread : doing legacy config system init 9055.773071457:main thread : tplAddLine processing template 'RSYSLOG_DebugFormat' 9055.773091856:main thread : tplAddLine processing template 'RSYSLOG_SyslogProtocol23Format' 9055.773099121:main thread : tplAddLine processing template 'RSYSLOG_FileFormat' 9055.773100357:main thread : template bound to strgen 'RSYSLOG_FileFormat' 9055.773101926:main thread : tplAddLine processing template 'RSYSLOG_TraditionalFileFormat' 9055.773102966:main thread : template bound to strgen 'RSYSLOG_TraditionalFileFormat' 9055.773103902:main thread : tplAddLine processing template ' WallFmt' 9055.773108087:main thread : tplAddLine processing template 'RSYSLOG_ForwardFormat' 9055.773109081:main thread : template bound to strgen 'RSYSLOG_ForwardFormat' 9055.773110004:main thread : tplAddLine processing template 'RSYSLOG_TraditionalForwardFormat' 9055.773111061:main thread : template bound to strgen 'RSYSLOG_TraditionalForwardFormat' 9055.773111982:main thread : tplAddLine processing template ' StdUsrMsgFmt' 9055.773113893:main thread : tplAddLine processing template ' StdDBFmt' 9055.773121885:main thread : tplAddLine processing template 'RSYSLOG_SysklogdFileFormat' 9055.773125186:main thread : tplAddLine processing template ' StdPgSQLFmt' 9055.773132489:main thread : tplAddLine processing template ' StdJSONFmt' 9055.773138565:main thread : tplAddLine processing template 'RSYSLOG_omudpspoofDfltSourceTpl' 9055.773159396:main thread : config parser: pushed file /etc/rsyslog.conf on top of stack Starting parse Entering state 0 Reducing stack by rule 1 (line 127): -> $$ = nterm conf () Stack now 0 Entering state 1 Reading a token: Next token is token BEGINOBJ () Shifting token BEGINOBJ () Entering state 3 Reducing stack by rule 17 (line 152): -> $$ = nterm nvlst () Stack now 0 1 3 Entering state 25 Reading a token: Next token is token NAME () Shifting token NAME () Entering state 50 Reading a token: Next token is token '=' () Shifting token '=' () Entering state 89 Reading a token: Next token is token STRING () Shifting token STRING () Entering state 123 Reducing stack by rule 20 (line 155): $1 = token STRING () -> $$ = nterm value () Stack now 0 1 3 25 50 89 Entering state 124 Reducing stack by rule 19 (line 154): $1 = token NAME () $2 = token '=' () $3 = nterm value () -> $$ = nterm nv () Stack now 0 1 3 25 Entering state 52 Reducing stack by rule 18 (line 153): $1 = nterm nvlst () $2 = nterm nv () -> $$ = nterm nvlst () Stack now 0 1 3 Entering state 25 Reading a token: Next token is token ENDOBJ () Shifting token ENDOBJ () Entering state 51 Reducing stack by rule 7 (line 133): $1 = token BEGINOBJ () $2 = nterm nvlst () $3 = token ENDOBJ () -> $$ = nterm obj () Stack now 0 1 Entering state 21 Reducing stack by rule 2 (line 128): $1 = nterm conf () $2 = nterm obj () 9055.773225693:main thread : cnf:global:obj: obj: 'module' 9055.773227716:main thread : nvlst 0x2aa000be1b0: 9055.773229238:main thread : name: 'load', value 'imuxsock' 9055.773231631:main thread : nvlstGetParam: name 'load', type 13, valnode->bUsed 0 9055.773232895:main thread : modulesProcessCnf params: 9055.773233711:main thread : load: 'imuxsock' 9055.773236976:main thread : Requested to load module 'imuxsock' 9055.773238361:main thread : loading module '/usr/lib/rsyslog/imuxsock.so' 9055.775786102:main thread : imuxsock version 8.14.0 initializing 9055.775790665:main thread : rsyslog/glbl: using '127.0.0.1' as localhost IP 9055.775815012:main thread : module imuxsock of type 0 being loaded (keepType=0). 9055.775816965:main thread : module config name is 'imuxsock' 9055.775818107:main thread : module imuxsock supports rsyslog v6 config interface 9055.775821649:main thread : module (global) param blk for imuxsock: 9055.775822576:main thread : syssock.use: (unset) 9055.775824447:main thread : syssock.name: (unset) 9055.775826227:main thread : syssock.unlink: (unset) 9055.775827944:main thread : syssock.ignoretimestamp: (unset) 9055.775829630:main thread : syssock.ignoreownmessages: (unset) 9055.775831351:main thread : syssock.flowcontrol: (unset) 9055.775833047:main thread : syssock.usesystimestamp: (unset) 9055.775834748:main thread : syssock.annotate: (unset) 9055.775836431:main thread : syssock.parsetrusted: (unset) 9055.775838110:main thread : syssock.usespecialparser: (unset) 9055.775839793:main thread : syssock.parsehostname: (unset) 9055.775841452:main thread : syssock.usepidfromsystem: (unset) 9055.775843110:main thread : syssock.ratelimit.interval: (unset) 9055.775844777:main thread : syssock.ratelimit.burst: (unset) 9055.775846441:main thread : syssock.ratelimit.severity: (unset) -> $$ = nterm conf () Stack now 0 Entering state 1 Reading a token: Next token is token BEGINOBJ () Shifting token BEGINOBJ () Entering state 3 Reducing stack by rule 17 (line 152): -> $$ = nterm nvlst () Stack now 0 1 3 Entering state 25 Reading a token: Next token is token NAME () Shifting token NAME () Entering state 50 Reading a token: Next token is token '=' () Shifting token '=' () Entering state 89 Reading a token: Next token is token STRING () Shifting token STRING () Entering state 123 Reducing stack by rule 20 (line 155): $1 = token STRING () -> $$ = nterm value () Stack now 0 1 3 25 50 89 Entering state 124 Reducing stack by rule 19 (line 154): $1 = token NAME () $2 = token '=' () $3 = nterm value () -> $$ = nterm nv () Stack now 0 1 3 25 Entering state 52 Reducing stack by rule 18 (line 153): $1 = nterm nvlst () $2 = nterm nv () -> $$ = nterm nvlst () Stack now 0 1 3 Entering state 25 Reading a token: Next token is token ENDOBJ () Shifting token ENDOBJ () Entering state 51 Reducing stack by rule 7 (line 133): $1 = token BEGINOBJ () $2 = nterm nvlst () $3 = token ENDOBJ () -> $$ = nterm obj () Stack now 0 1 Entering state 21 Reducing stack by rule 2 (line 128): $1 = nterm conf () $2 = nterm obj () 9055.775903235:main thread : cnf:global:obj: obj: 'module' 9055.775904795:main thread : nvlst 0x2aa000be1e0: 9055.775905915:main thread : name: 'load', value 'imklog' 9055.775907290:main thread : nvlstGetParam: name 'load', type 13, valnode->bUsed 0 9055.775908339:main thread : modulesProcessCnf params: 9055.775909155:main thread : load: 'imklog' 9055.775911150:main thread : Requested to load module 'imklog' 9055.775912462:main thread : loading module '/usr/lib/rsyslog/imklog.so' 9055.777285228:main thread : module imklog of type 0 being loaded (keepType=0). 9055.777287362:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.777289084:main thread : module config name is 'imklog' 9055.777290260:main thread : module imklog supports rsyslog v6 config interface 9055.777292736:main thread : entry point 'newInpInst' not present in module 9055.777294370:main thread : module (global) param blk for imklog: 9055.777295230:main thread : logpath: (unset) 9055.777297046:main thread : permitnonkernelfacility: (unset) 9055.777298814:main thread : consoleloglevel: (unset) 9055.777300526:main thread : parsekerneltimestamp: (unset) 9055.777302249:main thread : keepkerneltimestamp: (unset) 9055.777303933:main thread : internalmsgfacility: (unset) -> $$ = nterm conf () Stack now 0 Entering state 1 Reading a token: 9055.777315307:main thread : cnf:global:cfsysline: $KLogPermitNonKernelFacility on 9055.777319955:main thread : Called LogMsg, msg: command 'KLogPermitNonKernelFacility' is currently not permitted - did you already set it via a RainerScript command (v6+ config)? rsyslogd: command 'KLogPermitNonKernelFacility' is currently not permitted - did you already set it via a RainerScript command (v6+ config)? [v8.14.0 try http://www.rsyslog.com/e/2222 ] 9055.777346798:main thread : cnf:global:cfsysline: $ActionFileDefaultTemplate RSYSLOG_TraditionalFileFormat 9055.777349976:main thread : doGetWord: get newval 'RSYSLOG_TraditionalFileFormat' (len 29), hdlr 0x2aa0005daa8 9055.777351713:main thread : cnf:global:cfsysline: $RepeatedMsgReduction on 9055.777354325:main thread : cnf:global:cfsysline: $FileOwner syslog 9055.786158666:main thread : uid 104 obtained for user 'syslog' 9055.786163952:main thread : cnf:global:cfsysline: $FileGroup adm 9055.786191747:main thread : gid 4 obtained for group 'adm' 9055.786193790:main thread : cnf:global:cfsysline: $FileCreateMode 0640 9055.786195691:main thread : cnf:global:cfsysline: $DirCreateMode 0755 9055.786197317:main thread : cnf:global:cfsysline: $Umask 0022 9055.786199020:main thread : cnf:global:cfsysline: $PrivDropToUser syslog 9055.786210888:main thread : uid 104 obtained for user 'syslog' 9055.786212613:main thread : cnf:global:cfsysline: $PrivDropToGroup syslog 9055.786225567:main thread : gid 109 obtained for group 'syslog' 9055.786228125:main thread : cnf:global:cfsysline: $WorkDirectory /var/spool/rsyslog 9055.786230075:main thread : doGetWord: get newval '/var/spool/rsyslog' (len 18), hdlr 0x2aa00018c40 9055.786254790:main thread : requested to include config file '/etc/rsyslog.d/50-default.conf' 9055.786272259:main thread : config parser: pushed file /etc/rsyslog.d/50-default.conf on top of stack 9055.786274423:main thread : requested to include config file '/etc/rsyslog.d/25-juju-xnox-local.conf' 9055.786290114:main thread : config parser: pushed file /etc/rsyslog.d/25-juju-xnox-local.conf on top of stack 9055.786293209:main thread : cnf:global:cfsysline: $ModLoad imuxsock 9055.786295697:main thread : Requested to load module 'imuxsock' 9055.786297071:main thread : Module 'imuxsock' found 9055.786298053:main thread : Module 'imuxsock' already loaded 9055.786299125:main thread : module 'imuxsock' already in this config 9055.786302813:main thread : Called LogMsg, msg: module 'imuxsock' already in this config, cannot be added rsyslogd: module 'imuxsock' already in this config, cannot be added [v8.14.0 try http://www.rsyslog.com/e/2221 ] 9055.786309378:main thread : cnf:global:cfsysline: $ModLoad imfile 9055.786310948:main thread : Requested to load module 'imfile' 9055.786312293:main thread : loading module '/usr/lib/rsyslog/imfile.so' 9055.787938352:main thread : imfile: version 8.14.0 initializing 9055.787954404:main thread : module imfile of type 0 being loaded (keepType=0). 9055.787956547:main thread : module config name is 'imfile' 9055.787957760:main thread : module imfile supports rsyslog v6 config interface 9055.787959705:main thread : entry point 'activateCnfPrePrivDrop' not present in module 9055.787964183:main thread : cnf:global:cfsysline: $template JujuLogFormat-xnox-local,"%syslogtag:17:$%%msg:::sp-if-no-1st-sp%%msg:::drop-last-lf%\n" 9055.787966127:main thread : tplAddLine processing template 'JujuLogFormat-xnox-local' 9055.787971200:main thread : cnf:global:cfsysline: $template LongTagForwardFormat,"<%PRI%>%TIMESTAMP:::date-rfc3339% %HOSTNAME% %syslogtag%%msg:::sp-if-no-1st-sp%%msg%" 9055.787972740:main thread : tplAddLine processing template 'LongTagForwardFormat' 9055.787978494:main thread : cnf:global:cfsysline: $ActionQueueType LinkedList 9055.787980481:main thread : doGetWord: get newval 'LinkedList' (len 10), hdlr 0x2aa00049188 9055.787981855:main thread : action queue type set to LINKEDLIST 9055.787983446:main thread : cnf:global:cfsysline: $ActionQueueFileName machine-0-xnox-local_0 9055.787985016:main thread : doGetWord: get newval 'machine-0-xnox-local_0' (len 22), hdlr (nil) 9055.787986172:main thread : cnf:global:cfsysline: $ActionResumeRetryCount -1 9055.787987896:main thread : cnf:global:cfsysline: $ActionQueueSaveOnShutdown on 9055.787989841:main thread : cnf:global:cfsysline: $ActionQueueMaxDiskSpace 512M 9055.787991430:main thread : cnf:global:cfsysline: $DefaultNetstreamDriver gtls 9055.787992929:main thread : doGetWord: get newval 'gtls' (len 4), hdlr (nil) 9055.787994414:main thread : cnf:global:cfsysline: $DefaultNetstreamDriverCAFile /etc/juju-xnox-local/rsyslog/ca-cert.pem 9055.787995914:main thread : doGetWord: get newval '/etc/juju-xnox-local/rsyslog/ca-cert.pem' (len 40), hdlr (nil) 9055.787997077:main thread : cnf:global:cfsysline: $ActionSendStreamDriverAuthMode anon 9055.787999398:main thread : doGetWord: get newval 'anon' (len 4), hdlr (nil) 9055.788000743:main thread : cnf:global:cfsysline: $ActionSendStreamDriverMode 1 # run driver in TLS-only mode 9055.788003605:main thread : lexer: propfilt is ':syslogtag, startswith, "juju-xnox-local-"' Next token is token PROPFILT () Shifting token PROPFILT () Entering state 16 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.788014629:main thread : tried selector action for builtin:omfile: -2001 9055.788015825:main thread : tried selector action for builtin:ompipe: -2001 9055.788017153:main thread : tried selector action for builtin-shell: -2001 9055.788018391:main thread : tried selector action for builtin:omdiscard: -2001 9055.788020435:main thread : caller requested object 'netstrms', not found (iRet -3003) 9055.788021418:main thread : Requested to load module 'lmnetstrms' 9055.788022770:main thread : loading module '/usr/lib/rsyslog/lmnetstrms.so' 9055.789866227:main thread : doing nsselClassInit 9055.789869005:main thread : doing nspollClassInit 9055.789872276:main thread : module lmnetstrms of type 2 being loaded (keepType=0). 9055.789873507:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.789874481:main thread : entry point 'setModCnf' not present in module 9055.789875452:main thread : entry point 'getModCnfName' not present in module 9055.789876398:main thread : entry point 'beginCnfLoad' not present in module 9055.789878103:main thread : source file omfwd.c requested reference for module 'lmnetstrms', reference count now 1 9055.789879564:main thread : source file omfwd.c requested reference for module 'lmnetstrms', reference count now 2 9055.789881232:main thread : caller requested object 'tcpclt', not found (iRet -3003) 9055.789882245:main thread : Requested to load module 'lmtcpclt' 9055.789883706:main thread : loading module '/usr/lib/rsyslog/lmtcpclt.so' 9055.790982925:main thread : module lmtcpclt of type 2 being loaded (keepType=0). 9055.790985016:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.790986190:main thread : entry point 'setModCnf' not present in module 9055.790987206:main thread : entry point 'getModCnfName' not present in module 9055.790988208:main thread : entry point 'beginCnfLoad' not present in module 9055.790989990:main thread : source file omfwd.c requested reference for module 'lmtcpclt', reference count now 1 9055.790992377:main thread : tried selector action for builtin:omfwd: 0 9055.790993555:main thread : Module builtin:omfwd processes this action. 9055.790995680:main thread : template: 'LongTagForwardFormat' assigned 9055.791001165:main thread : action 0 queue: parameter dump: 9055.791002289:main thread : action 0 queue: queue.filename 'machine-0-xnox-local_0' 9055.791003352:main thread : action 0 queue: queue.size: 1000 9055.791004485:main thread : action 0 queue: queue.dequeuebatchsize: 16 9055.791005571:main thread : action 0 queue: queue.maxdiskspace: 512000000 9055.791006603:main thread : action 0 queue: queue.highwatermark: -1 9055.791007643:main thread : action 0 queue: queue.lowwatermark: -1 9055.791008604:main thread : action 0 queue: queue.fulldelaymark: -1 9055.791009550:main thread : action 0 queue: queue.lightdelaymark: -1 9055.791010601:main thread : action 0 queue: queue.discardmark: 980 9055.791011562:main thread : action 0 queue: queue.discardseverity: 8 9055.791012542:main thread : action 0 queue: queue.checkpointinterval: 0 9055.791013545:main thread : action 0 queue: queue.syncqueuefiles: 0 9055.791014730:main thread : action 0 queue: queue.type: 1 [LinkedList] 9055.791015694:main thread : action 0 queue: queue.workerthreads: 1 9055.791016668:main thread : action 0 queue: queue.timeoutshutdown: 0 9055.791018046:main thread : action 0 queue: queue.timeoutactioncompletion: 1000 9055.791019029:main thread : action 0 queue: queue.timeoutenqueue: 50 9055.791020060:main thread : action 0 queue: queue.timeoutworkerthreadshutdown: 60000 9055.791021047:main thread : action 0 queue: queue.workerthreadminimummessages: -1 9055.791022074:main thread : action 0 queue: queue.maxfilesize: 1048576 9055.791023049:main thread : action 0 queue: queue.saveonshutdown: 1 9055.791024051:main thread : action 0 queue: queue.dequeueslowdown: 0 9055.791025028:main thread : action 0 queue: queue.dequeuetimebegin: 0 9055.791026011:main thread : action 0 queue: queue.dequeuetimeend: 25 9055.791027450:main thread : Action 0x2aa000c9ae0: queue 0x2aa000c9ee0 created -> $$ = nterm s_act () Stack now 0 1 16 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 16 Entering state 23 Reading a token: 9055.791039256:main thread : cnf:global:cfsysline: $ActionQueueType LinkedList 9055.791041637:main thread : doGetWord: get newval 'LinkedList' (len 10), hdlr 0x2aa00049188 9055.791042575:main thread : action queue type set to LINKEDLIST 9055.791044053:main thread : cnf:global:cfsysline: $ActionQueueFileName machine-0-xnox-local_1 9055.791045644:main thread : doGetWord: get newval 'machine-0-xnox-local_1' (len 22), hdlr (nil) 9055.791046768:main thread : cnf:global:cfsysline: $ActionResumeRetryCount -1 9055.791048539:main thread : cnf:global:cfsysline: $ActionQueueSaveOnShutdown on 9055.791050415:main thread : cnf:global:cfsysline: $ActionQueueMaxDiskSpace 512M 9055.791051901:main thread : cnf:global:cfsysline: $DefaultNetstreamDriver gtls 9055.791053312:main thread : doGetWord: get newval 'gtls' (len 4), hdlr (nil) 9055.791054808:main thread : cnf:global:cfsysline: $DefaultNetstreamDriverCAFile /etc/juju-xnox-local/rsyslog/ca-cert.pem 9055.791056280:main thread : doGetWord: get newval '/etc/juju-xnox-local/rsyslog/ca-cert.pem' (len 40), hdlr (nil) 9055.791057452:main thread : cnf:global:cfsysline: $ActionSendStreamDriverAuthMode anon 9055.791059564:main thread : doGetWord: get newval 'anon' (len 4), hdlr (nil) 9055.791060883:main thread : cnf:global:cfsysline: $ActionSendStreamDriverMode 1 # run driver in TLS-only mode 9055.791063302:main thread : lexer: propfilt is ':syslogtag, startswith, "juju-xnox-local-"' Next token is token PROPFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 16 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 16 Entering state 36 Reducing stack by rule 32 (line 175): $1 = token PROPFILT () $2 = nterm block () 9055.791078248:main thread : Decoding property-based filter ':syslogtag, startswith, "juju-xnox-local-"' -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.791086815:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PROPFILT () Shifting token PROPFILT () Entering state 16 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.791098608:main thread : tried selector action for builtin:omfile: -2001 9055.791099675:main thread : tried selector action for builtin:ompipe: -2001 9055.791100875:main thread : tried selector action for builtin-shell: -2001 9055.791102004:main thread : tried selector action for builtin:omdiscard: -2001 9055.791103878:main thread : tried selector action for builtin:omfwd: 0 9055.791104830:main thread : Module builtin:omfwd processes this action. 9055.791106111:main thread : template: 'LongTagForwardFormat' assigned 9055.791108481:main thread : action 1 queue: parameter dump: 9055.791109479:main thread : action 1 queue: queue.filename 'machine-0-xnox-local_1' 9055.791110757:main thread : action 1 queue: queue.size: 1000 9055.791111757:main thread : action 1 queue: queue.dequeuebatchsize: 16 9055.791112798:main thread : action 1 queue: queue.maxdiskspace: 512000000 9055.791113776:main thread : action 1 queue: queue.highwatermark: -1 9055.791114753:main thread : action 1 queue: queue.lowwatermark: -1 9055.791115672:main thread : action 1 queue: queue.fulldelaymark: -1 9055.791116619:main thread : action 1 queue: queue.lightdelaymark: -1 9055.791117584:main thread : action 1 queue: queue.discardmark: 980 9055.791118515:main thread : action 1 queue: queue.discardseverity: 8 9055.791119500:main thread : action 1 queue: queue.checkpointinterval: 0 9055.791120442:main thread : action 1 queue: queue.syncqueuefiles: 0 9055.791121482:main thread : action 1 queue: queue.type: 1 [LinkedList] 9055.791122414:main thread : action 1 queue: queue.workerthreads: 1 9055.791123340:main thread : action 1 queue: queue.timeoutshutdown: 0 9055.791124321:main thread : action 1 queue: queue.timeoutactioncompletion: 1000 9055.791125307:main thread : action 1 queue: queue.timeoutenqueue: 50 9055.791126300:main thread : action 1 queue: queue.timeoutworkerthreadshutdown: 60000 9055.791127266:main thread : action 1 queue: queue.workerthreadminimummessages: -1 9055.791128294:main thread : action 1 queue: queue.maxfilesize: 1048576 9055.791129244:main thread : action 1 queue: queue.saveonshutdown: 1 9055.791130200:main thread : action 1 queue: queue.dequeueslowdown: 0 9055.791131134:main thread : action 1 queue: queue.dequeuetimebegin: 0 9055.791132093:main thread : action 1 queue: queue.dequeuetimeend: 25 9055.791133296:main thread : Action 0x2aa000ca660: queue 0x2aa000caa20 created -> $$ = nterm s_act () Stack now 0 1 16 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 16 Entering state 23 Reading a token: 9055.791143482:main thread : cnf:global:cfsysline: $ActionQueueType LinkedList 9055.791145264:main thread : doGetWord: get newval 'LinkedList' (len 10), hdlr 0x2aa00049188 9055.791146138:main thread : action queue type set to LINKEDLIST 9055.791147478:main thread : cnf:global:cfsysline: $ActionQueueFileName machine-0-xnox-local_2 9055.791148879:main thread : doGetWord: get newval 'machine-0-xnox-local_2' (len 22), hdlr (nil) 9055.791149963:main thread : cnf:global:cfsysline: $ActionResumeRetryCount -1 9055.791151612:main thread : cnf:global:cfsysline: $ActionQueueSaveOnShutdown on 9055.791153427:main thread : cnf:global:cfsysline: $ActionQueueMaxDiskSpace 512M 9055.791154842:main thread : cnf:global:cfsysline: $DefaultNetstreamDriver gtls 9055.791156204:main thread : doGetWord: get newval 'gtls' (len 4), hdlr (nil) 9055.791157620:main thread : cnf:global:cfsysline: $DefaultNetstreamDriverCAFile /etc/juju-xnox-local/rsyslog/ca-cert.pem 9055.791159072:main thread : doGetWord: get newval '/etc/juju-xnox-local/rsyslog/ca-cert.pem' (len 40), hdlr (nil) 9055.791160214:main thread : cnf:global:cfsysline: $ActionSendStreamDriverAuthMode anon 9055.791162206:main thread : doGetWord: get newval 'anon' (len 4), hdlr (nil) 9055.791163544:main thread : cnf:global:cfsysline: $ActionSendStreamDriverMode 1 # run driver in TLS-only mode 9055.791165809:main thread : lexer: propfilt is ':syslogtag, startswith, "juju-xnox-local-"' Next token is token PROPFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 16 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 16 Entering state 36 Reducing stack by rule 32 (line 175): $1 = token PROPFILT () $2 = nterm block () 9055.791180352:main thread : Decoding property-based filter ':syslogtag, startswith, "juju-xnox-local-"' -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.791189214:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PROPFILT () Shifting token PROPFILT () Entering state 16 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.791200865:main thread : tried selector action for builtin:omfile: -2001 9055.791201925:main thread : tried selector action for builtin:ompipe: -2001 9055.791203043:main thread : tried selector action for builtin-shell: -2001 9055.791204144:main thread : tried selector action for builtin:omdiscard: -2001 9055.791205901:main thread : tried selector action for builtin:omfwd: 0 9055.791206860:main thread : Module builtin:omfwd processes this action. 9055.791208113:main thread : template: 'LongTagForwardFormat' assigned 9055.791210382:main thread : action 2 queue: parameter dump: 9055.791211372:main thread : action 2 queue: queue.filename 'machine-0-xnox-local_2' 9055.791212394:main thread : action 2 queue: queue.size: 1000 9055.791213381:main thread : action 2 queue: queue.dequeuebatchsize: 16 9055.791214424:main thread : action 2 queue: queue.maxdiskspace: 512000000 9055.791215405:main thread : action 2 queue: queue.highwatermark: -1 9055.791216386:main thread : action 2 queue: queue.lowwatermark: -1 9055.791217308:main thread : action 2 queue: queue.fulldelaymark: -1 9055.791218244:main thread : action 2 queue: queue.lightdelaymark: -1 9055.791219212:main thread : action 2 queue: queue.discardmark: 980 9055.791220164:main thread : action 2 queue: queue.discardseverity: 8 9055.791221136:main thread : action 2 queue: queue.checkpointinterval: 0 9055.791222092:main thread : action 2 queue: queue.syncqueuefiles: 0 9055.791223134:main thread : action 2 queue: queue.type: 1 [LinkedList] 9055.791224065:main thread : action 2 queue: queue.workerthreads: 1 9055.791225009:main thread : action 2 queue: queue.timeoutshutdown: 0 9055.791225981:main thread : action 2 queue: queue.timeoutactioncompletion: 1000 9055.791226928:main thread : action 2 queue: queue.timeoutenqueue: 50 9055.791227922:main thread : action 2 queue: queue.timeoutworkerthreadshutdown: 60000 9055.791228870:main thread : action 2 queue: queue.workerthreadminimummessages: -1 9055.791229888:main thread : action 2 queue: queue.maxfilesize: 1048576 9055.791230834:main thread : action 2 queue: queue.saveonshutdown: 1 9055.791231801:main thread : action 2 queue: queue.dequeueslowdown: 0 9055.791232733:main thread : action 2 queue: queue.dequeuetimebegin: 0 9055.791233684:main thread : action 2 queue: queue.dequeuetimeend: 25 9055.791234863:main thread : Action 0x2aa000cb170: queue 0x2aa000cb570 created -> $$ = nterm s_act () Stack now 0 1 16 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 16 Entering state 23 Reading a token: 9055.791244925:main thread : lexer: propfilt is ':syslogtag, startswith, "juju-xnox-local-"' Next token is token PROPFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 16 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 16 Entering state 36 Reducing stack by rule 32 (line 175): $1 = token PROPFILT () $2 = nterm block () 9055.791259314:main thread : Decoding property-based filter ':syslogtag, startswith, "juju-xnox-local-"' -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.791266732:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PROPFILT () Shifting token PROPFILT () Entering state 16 Reading a token: Next token is token STOP () Shifting token STOP () Entering state 7 Reducing stack by rule 39 (line 183): $1 = token STOP () -> $$ = nterm s_act () Stack now 0 1 16 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 16 Entering state 23 Reading a token: 9055.791286628:main thread : cnf:global:cfsysline: $FileCreateMode 0600 9055.791290696:main thread : cnf:global:cfsysline: $outchannel logRotation,/var/log/juju-xnox-local/all-machines.log,536870912,/etc/juju-xnox-local/rsyslog/logrotate.run Next token is token LEGACY_RULESET () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 16 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 16 Entering state 36 Reducing stack by rule 32 (line 175): $1 = token PROPFILT () $2 = nterm block () 9055.791307228:main thread : Decoding property-based filter ':syslogtag, startswith, "juju-xnox-local-"' -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.791314506:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token LEGACY_RULESET () Shifting token LEGACY_RULESET () Entering state 14 Reducing stack by rule 4 (line 130): $1 = nterm conf () $2 = token LEGACY_RULESET () 9055.791323461:main thread : cnf:global:cfsysline: $RuleSet remote 9055.791325337:main thread : doGetWord: get newval 'remote' (len 6), hdlr 0x2aa0001bc30 9055.791326518:main thread : begin new current rule set 'remote' -> $$ = nterm conf () Stack now 0 Entering state 1 Reading a token: 9055.791330808:main thread : cnf:global:cfsysline: $FileCreateMode 0600 9055.791332733:main thread : lexer: propfilt is ':syslogtag, startswith, "juju-xnox-local-"' Next token is token PROPFILT () Shifting token PROPFILT () Entering state 16 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.791343166:main thread : tried selector action for builtin:omfile: 0 9055.791344122:main thread : Module builtin:omfile processes this action. 9055.791345325:main thread : template: 'JujuLogFormat-xnox-local' assigned 9055.791347516:main thread : action 3 queue: parameter dump: 9055.791348505:main thread : action 3 queue: queue.filename '[NONE]' 9055.791349519:main thread : action 3 queue: queue.size: 1000 9055.791350494:main thread : action 3 queue: queue.dequeuebatchsize: 16 9055.791351517:main thread : action 3 queue: queue.maxdiskspace: 0 9055.791352465:main thread : action 3 queue: queue.highwatermark: -1 9055.791353422:main thread : action 3 queue: queue.lowwatermark: -1 9055.791354339:main thread : action 3 queue: queue.fulldelaymark: -1 9055.791355268:main thread : action 3 queue: queue.lightdelaymark: -1 9055.791356255:main thread : action 3 queue: queue.discardmark: 980 9055.791357194:main thread : action 3 queue: queue.discardseverity: 8 9055.791358164:main thread : action 3 queue: queue.checkpointinterval: 0 9055.791359083:main thread : action 3 queue: queue.syncqueuefiles: 0 9055.791360144:main thread : action 3 queue: queue.type: 3 [Direct] 9055.791361081:main thread : action 3 queue: queue.workerthreads: 1 9055.791362005:main thread : action 3 queue: queue.timeoutshutdown: 0 9055.791362982:main thread : action 3 queue: queue.timeoutactioncompletion: 1000 9055.791363927:main thread : action 3 queue: queue.timeoutenqueue: 50 9055.791364931:main thread : action 3 queue: queue.timeoutworkerthreadshutdown: 60000 9055.791365864:main thread : action 3 queue: queue.workerthreadminimummessages: -1 9055.791366857:main thread : action 3 queue: queue.maxfilesize: 1048576 9055.791367808:main thread : action 3 queue: queue.saveonshutdown: 1 9055.791368760:main thread : action 3 queue: queue.dequeueslowdown: 0 9055.791369699:main thread : action 3 queue: queue.dequeuetimebegin: 0 9055.791370895:main thread : action 3 queue: queue.dequeuetimeend: 25 9055.791372062:main thread : Action 0x2aa000cc200: queue 0x2aa000cc600 created -> $$ = nterm s_act () Stack now 0 1 16 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 16 Entering state 23 Reading a token: 9055.791381732:main thread : lexer: propfilt is ':syslogtag, startswith, "juju-xnox-local-"' Next token is token PROPFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 16 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 16 Entering state 36 Reducing stack by rule 32 (line 175): $1 = token PROPFILT () $2 = nterm block () 9055.791396179:main thread : Decoding property-based filter ':syslogtag, startswith, "juju-xnox-local-"' -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.791403484:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PROPFILT () Shifting token PROPFILT () Entering state 16 Reading a token: Next token is token STOP () Shifting token STOP () Entering state 7 Reducing stack by rule 39 (line 183): $1 = token STOP () -> $$ = nterm s_act () Stack now 0 1 16 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 16 Entering state 23 Reading a token: 9055.791422612:main thread : cnf:global:cfsysline: $FileCreateMode 0600 9055.791424297:main thread : cnf:global:cfsysline: $InputFilePersistStateInterval 50 9055.791426932:main thread : cnf:global:cfsysline: $InputFilePollInterval 5 9055.791429591:main thread : cnf:global:cfsysline: $InputFileName /var/log/juju-xnox-local/machine-0.log 9055.791431635:main thread : doGetWord: get newval '/var/log/juju-xnox-local/machine-0.log' (len 38), hdlr (nil) 9055.791432870:main thread : cnf:global:cfsysline: $InputFileTag juju-xnox-local-machine-0: 9055.791434854:main thread : doGetWord: get newval 'juju-xnox-local-machine-0:' (len 26), hdlr (nil) 9055.791436025:main thread : cnf:global:cfsysline: $InputFileStateFile machine-0-xnox-local 9055.791438016:main thread : doGetWord: get newval 'machine-0-xnox-local' (len 20), hdlr (nil) 9055.791439091:main thread : cnf:global:cfsysline: $InputRunFileMonitor 9055.791441213:main thread : doGetWord: get newval '' (len 0), hdlr 0x3fffd782f10 9055.791445232:main thread : cnf:global:cfsysline: $ModLoad imtcp 9055.791446753:main thread : Requested to load module 'imtcp' 9055.791448121:main thread : loading module '/usr/lib/rsyslog/imtcp.so' 9055.792748165:main thread : source file imtcp.c requested reference for module 'lmnet', reference count now 4 9055.792750552:main thread : source file imtcp.c requested reference for module 'lmnetstrms', reference count now 3 9055.792752444:main thread : caller requested object 'tcps_sess', not found (iRet -3003) 9055.792753610:main thread : Requested to load module 'lmtcpsrv' 9055.792755200:main thread : loading module '/usr/lib/rsyslog/lmtcpsrv.so' 9055.795248289:main thread : source file tcps_sess.c requested reference for module 'lmnetstrms', reference count now 4 9055.795255547:main thread : source file tcpsrv.c requested reference for module 'lmnet', reference count now 5 9055.795257873:main thread : source file tcpsrv.c requested reference for module 'lmnetstrms', reference count now 5 9055.795263618:main thread : module lmtcpsrv of type 2 being loaded (keepType=0). 9055.795265306:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.795266668:main thread : entry point 'setModCnf' not present in module 9055.795268455:main thread : entry point 'getModCnfName' not present in module 9055.795269951:main thread : entry point 'beginCnfLoad' not present in module 9055.795271941:main thread : source file imtcp.c requested reference for module 'lmtcpsrv', reference count now 1 9055.795273941:main thread : source file imtcp.c requested reference for module 'lmtcpsrv', reference count now 2 9055.795313494:main thread : module imtcp of type 0 being loaded (keepType=0). 9055.795315836:main thread : module config name is 'imtcp' 9055.795317185:main thread : module imtcp supports rsyslog v6 config interface 9055.795321967:main thread : cnf:global:cfsysline: $DefaultNetstreamDriver gtls 9055.795324289:main thread : doGetWord: get newval 'gtls' (len 4), hdlr (nil) 9055.795326456:main thread : cnf:global:cfsysline: $DefaultNetstreamDriverCAFile /etc/juju-xnox-local/rsyslog/ca-cert.pem 9055.795328539:main thread : doGetWord: get newval '/etc/juju-xnox-local/rsyslog/ca-cert.pem' (len 40), hdlr (nil) 9055.795330371:main thread : cnf:global:cfsysline: $DefaultNetstreamDriverCertFile /etc/juju-xnox-local/rsyslog/rsyslog-cert.pem 9055.795332381:main thread : doGetWord: get newval '/etc/juju-xnox-local/rsyslog/rsyslog-cert.pem' (len 45), hdlr (nil) 9055.795334396:main thread : cnf:global:cfsysline: $DefaultNetstreamDriverKeyFile /etc/juju-xnox-local/rsyslog/rsyslog-key.pem 9055.795337104:main thread : doGetWord: get newval '/etc/juju-xnox-local/rsyslog/rsyslog-key.pem' (len 44), hdlr (nil) 9055.795338711:main thread : cnf:global:cfsysline: $InputTCPServerStreamDriverAuthMode anon 9055.795341888:main thread : doGetWord: get newval 'anon' (len 4), hdlr (nil) 9055.795343872:main thread : cnf:global:cfsysline: $InputTCPServerStreamDriverMode 1 # run driver in TLS-only mode 9055.795348236:main thread : cnf:global:cfsysline: $InputTCPMaxSessions 10000 # default is 200, all agents connect to all rsyslog daemons 9055.795351591:main thread : cnf:global:cfsysline: $InputTCPServerBindRuleset remote 9055.795354730:main thread : doGetWord: get newval 'remote' (len 6), hdlr (nil) 9055.795356303:main thread : cnf:global:cfsysline: $InputTCPServerRun 6514 9055.795359420:main thread : doGetWord: get newval '6514' (len 4), hdlr 0x3fffd482470 Next token is token LEGACY_RULESET () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 16 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 16 Entering state 36 Reducing stack by rule 32 (line 175): $1 = token PROPFILT () $2 = nterm block () 9055.795382772:main thread : Decoding property-based filter ':syslogtag, startswith, "juju-xnox-local-"' -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.795394957:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token LEGACY_RULESET () Shifting token LEGACY_RULESET () Entering state 14 Reducing stack by rule 4 (line 130): $1 = nterm conf () $2 = token LEGACY_RULESET () 9055.795407664:main thread : cnf:global:cfsysline: $RuleSet RSYSLOG_DefaultRuleset 9055.795410492:main thread : doGetWord: get newval 'RSYSLOG_DefaultRuleset' (len 22), hdlr 0x2aa0001bc30 9055.795412146:main thread : current rule set changed to 0x2aa000b2750: 'RSYSLOG_DefaultRuleset' -> $$ = nterm conf () Stack now 0 Entering state 1 Reading a token: 9055.795417976:main thread : config parser: reached end of file /etc/rsyslog.d/25-juju-xnox-local.conf 9055.795419664:main thread : config parser: resume parsing of file /etc/rsyslog.d/50-default.conf at line 1 Next token is token PRIFILT () Shifting token PRIFILT () Entering state 15 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.795435773:main thread : tried selector action for builtin:omfile: 0 9055.795437238:main thread : Module builtin:omfile processes this action. 9055.795439187:main thread : template: 'RSYSLOG_TraditionalFileFormat' assigned 9055.795442821:main thread : action 4 queue: parameter dump: 9055.795444276:main thread : action 4 queue: queue.filename '[NONE]' 9055.795445746:main thread : action 4 queue: queue.size: 1000 9055.795447126:main thread : action 4 queue: queue.dequeuebatchsize: 16 9055.795448579:main thread : action 4 queue: queue.maxdiskspace: 0 9055.795449983:main thread : action 4 queue: queue.highwatermark: -1 9055.795451338:main thread : action 4 queue: queue.lowwatermark: -1 9055.795452639:main thread : action 4 queue: queue.fulldelaymark: -1 9055.795453958:main thread : action 4 queue: queue.lightdelaymark: -1 9055.795455333:main thread : action 4 queue: queue.discardmark: 980 9055.795456652:main thread : action 4 queue: queue.discardseverity: 8 9055.795458013:main thread : action 4 queue: queue.checkpointinterval: 0 9055.795459330:main thread : action 4 queue: queue.syncqueuefiles: 0 9055.795460782:main thread : action 4 queue: queue.type: 3 [Direct] 9055.795462114:main thread : action 4 queue: queue.workerthreads: 1 9055.795463445:main thread : action 4 queue: queue.timeoutshutdown: 0 9055.795464856:main thread : action 4 queue: queue.timeoutactioncompletion: 1000 9055.795466188:main thread : action 4 queue: queue.timeoutenqueue: 50 9055.795467582:main thread : action 4 queue: queue.timeoutworkerthreadshutdown: 60000 9055.795468933:main thread : action 4 queue: queue.workerthreadminimummessages: -1 9055.795470341:main thread : action 4 queue: queue.maxfilesize: 1048576 9055.795471727:main thread : action 4 queue: queue.saveonshutdown: 1 9055.795473068:main thread : action 4 queue: queue.dequeueslowdown: 0 9055.795474418:main thread : action 4 queue: queue.dequeuetimebegin: 0 9055.795475729:main thread : action 4 queue: queue.dequeuetimeend: 25 9055.795477438:main thread : Action 0x2aa000c5860: queue 0x2aa000c5c20 created -> $$ = nterm s_act () Stack now 0 1 15 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 15 Entering state 23 Reading a token: Next token is token PRIFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 15 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 15 Entering state 35 Reducing stack by rule 31 (line 174): $1 = token PRIFILT () $2 = nterm block () 9055.795510145:main thread : Decoding traditional PRI filter 'auth,authpriv.*' 9055.795511715:main thread : symbolic name: * ==> 255 9055.795515967:main thread : symbolic name: auth ==> 32 9055.795518274:main thread : symbolic name: authpriv ==> 80 -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.795528485:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PRIFILT () Shifting token PRIFILT () Entering state 15 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.795545242:main thread : tried selector action for builtin:omfile: 0 9055.795546646:main thread : Module builtin:omfile processes this action. 9055.795548314:main thread : template: 'RSYSLOG_TraditionalFileFormat' assigned 9055.795551860:main thread : action 5 queue: parameter dump: 9055.795553247:main thread : action 5 queue: queue.filename '[NONE]' 9055.795554639:main thread : action 5 queue: queue.size: 1000 9055.795556020:main thread : action 5 queue: queue.dequeuebatchsize: 16 9055.795557437:main thread : action 5 queue: queue.maxdiskspace: 0 9055.795558760:main thread : action 5 queue: queue.highwatermark: -1 9055.795560128:main thread : action 5 queue: queue.lowwatermark: -1 9055.795561456:main thread : action 5 queue: queue.fulldelaymark: -1 9055.795562770:main thread : action 5 queue: queue.lightdelaymark: -1 9055.795564116:main thread : action 5 queue: queue.discardmark: 980 9055.795565430:main thread : action 5 queue: queue.discardseverity: 8 9055.795566770:main thread : action 5 queue: queue.checkpointinterval: 0 9055.795568114:main thread : action 5 queue: queue.syncqueuefiles: 0 9055.795569550:main thread : action 5 queue: queue.type: 3 [Direct] 9055.795570841:main thread : action 5 queue: queue.workerthreads: 1 9055.795572195:main thread : action 5 queue: queue.timeoutshutdown: 0 9055.795573543:main thread : action 5 queue: queue.timeoutactioncompletion: 1000 9055.795574873:main thread : action 5 queue: queue.timeoutenqueue: 50 9055.795576238:main thread : action 5 queue: queue.timeoutworkerthreadshutdown: 60000 9055.795577563:main thread : action 5 queue: queue.workerthreadminimummessages: -1 9055.795578965:main thread : action 5 queue: queue.maxfilesize: 1048576 9055.795580305:main thread : action 5 queue: queue.saveonshutdown: 1 9055.795581621:main thread : action 5 queue: queue.dequeueslowdown: 0 9055.795582949:main thread : action 5 queue: queue.dequeuetimebegin: 0 9055.795584249:main thread : action 5 queue: queue.dequeuetimeend: 25 9055.795585873:main thread : Action 0x2aa000c6320: queue 0x2aa000cf1e0 created -> $$ = nterm s_act () Stack now 0 1 15 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 15 Entering state 23 Reading a token: Next token is token PRIFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 15 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 15 Entering state 35 Reducing stack by rule 31 (line 174): $1 = token PRIFILT () $2 = nterm block () 9055.795618424:main thread : Decoding traditional PRI filter '*.*;auth,authpriv.none' 9055.795619907:main thread : symbolic name: * ==> 255 9055.795622542:main thread : symbolic name: none ==> 16 9055.795624795:main thread : symbolic name: auth ==> 32 9055.795626922:main thread : symbolic name: authpriv ==> 80 -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.795636948:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PRIFILT () Shifting token PRIFILT () Entering state 15 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.795653448:main thread : tried selector action for builtin:omfile: 0 9055.795654830:main thread : Module builtin:omfile processes this action. 9055.795656418:main thread : template: 'RSYSLOG_TraditionalFileFormat' assigned 9055.795660682:main thread : action 6 queue: parameter dump: 9055.795662055:main thread : action 6 queue: queue.filename '[NONE]' 9055.795663455:main thread : action 6 queue: queue.size: 1000 9055.795664852:main thread : action 6 queue: queue.dequeuebatchsize: 16 9055.795666209:main thread : action 6 queue: queue.maxdiskspace: 0 9055.795667865:main thread : action 6 queue: queue.highwatermark: -1 9055.795669269:main thread : action 6 queue: queue.lowwatermark: -1 9055.795670602:main thread : action 6 queue: queue.fulldelaymark: -1 9055.795671905:main thread : action 6 queue: queue.lightdelaymark: -1 9055.795673258:main thread : action 6 queue: queue.discardmark: 980 9055.795674549:main thread : action 6 queue: queue.discardseverity: 8 9055.795675928:main thread : action 6 queue: queue.checkpointinterval: 0 9055.795677254:main thread : action 6 queue: queue.syncqueuefiles: 0 9055.795678698:main thread : action 6 queue: queue.type: 3 [Direct] 9055.795680052:main thread : action 6 queue: queue.workerthreads: 1 9055.795681376:main thread : action 6 queue: queue.timeoutshutdown: 0 9055.795682747:main thread : action 6 queue: queue.timeoutactioncompletion: 1000 9055.795684071:main thread : action 6 queue: queue.timeoutenqueue: 50 9055.795685449:main thread : action 6 queue: queue.timeoutworkerthreadshutdown: 60000 9055.795686760:main thread : action 6 queue: queue.workerthreadminimummessages: -1 9055.795688205:main thread : action 6 queue: queue.maxfilesize: 1048576 9055.795689520:main thread : action 6 queue: queue.saveonshutdown: 1 9055.795690871:main thread : action 6 queue: queue.dequeueslowdown: 0 9055.795692189:main thread : action 6 queue: queue.dequeuetimebegin: 0 9055.795693521:main thread : action 6 queue: queue.dequeuetimeend: 25 9055.795695118:main thread : Action 0x2aa000cf8e0: queue 0x2aa000cfce0 created -> $$ = nterm s_act () Stack now 0 1 15 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 15 Entering state 23 Reading a token: Next token is token PRIFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 15 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 15 Entering state 35 Reducing stack by rule 31 (line 174): $1 = token PRIFILT () $2 = nterm block () 9055.795727487:main thread : Decoding traditional PRI filter 'kern.*' 9055.795728829:main thread : symbolic name: * ==> 255 9055.795731183:main thread : symbolic name: kern ==> 0 -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.795741188:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PRIFILT () Shifting token PRIFILT () Entering state 15 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.795758735:main thread : tried selector action for builtin:omfile: 0 9055.795760090:main thread : Module builtin:omfile processes this action. 9055.795761688:main thread : template: 'RSYSLOG_TraditionalFileFormat' assigned 9055.795764728:main thread : action 7 queue: parameter dump: 9055.795766111:main thread : action 7 queue: queue.filename '[NONE]' 9055.795767495:main thread : action 7 queue: queue.size: 1000 9055.795768857:main thread : action 7 queue: queue.dequeuebatchsize: 16 9055.795770244:main thread : action 7 queue: queue.maxdiskspace: 0 9055.795771572:main thread : action 7 queue: queue.highwatermark: -1 9055.795772918:main thread : action 7 queue: queue.lowwatermark: -1 9055.795774228:main thread : action 7 queue: queue.fulldelaymark: -1 9055.795775504:main thread : action 7 queue: queue.lightdelaymark: -1 9055.795776914:main thread : action 7 queue: queue.discardmark: 980 9055.795778204:main thread : action 7 queue: queue.discardseverity: 8 9055.795779578:main thread : action 7 queue: queue.checkpointinterval: 0 9055.795780904:main thread : action 7 queue: queue.syncqueuefiles: 0 9055.795782338:main thread : action 7 queue: queue.type: 3 [Direct] 9055.795783664:main thread : action 7 queue: queue.workerthreads: 1 9055.795785008:main thread : action 7 queue: queue.timeoutshutdown: 0 9055.795786363:main thread : action 7 queue: queue.timeoutactioncompletion: 1000 9055.795787690:main thread : action 7 queue: queue.timeoutenqueue: 50 9055.795789052:main thread : action 7 queue: queue.timeoutworkerthreadshutdown: 60000 9055.795790372:main thread : action 7 queue: queue.workerthreadminimummessages: -1 9055.795791789:main thread : action 7 queue: queue.maxfilesize: 1048576 9055.795793106:main thread : action 7 queue: queue.saveonshutdown: 1 9055.795794458:main thread : action 7 queue: queue.dequeueslowdown: 0 9055.795795803:main thread : action 7 queue: queue.dequeuetimebegin: 0 9055.795797138:main thread : action 7 queue: queue.dequeuetimeend: 25 9055.795798743:main thread : Action 0x2aa000d03e0: queue 0x2aa000d07e0 created -> $$ = nterm s_act () Stack now 0 1 15 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 15 Entering state 23 Reading a token: Next token is token PRIFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 15 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 15 Entering state 35 Reducing stack by rule 31 (line 174): $1 = token PRIFILT () $2 = nterm block () 9055.795832677:main thread : Decoding traditional PRI filter 'mail.*' 9055.795834202:main thread : symbolic name: * ==> 255 9055.795836558:main thread : symbolic name: mail ==> 16 -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.795846646:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PRIFILT () Shifting token PRIFILT () Entering state 15 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.795862942:main thread : tried selector action for builtin:omfile: 0 9055.795864291:main thread : Module builtin:omfile processes this action. 9055.795867019:main thread : template: 'RSYSLOG_TraditionalFileFormat' assigned 9055.795870051:main thread : action 8 queue: parameter dump: 9055.795871436:main thread : action 8 queue: queue.filename '[NONE]' 9055.795872854:main thread : action 8 queue: queue.size: 1000 9055.795874196:main thread : action 8 queue: queue.dequeuebatchsize: 16 9055.795875602:main thread : action 8 queue: queue.maxdiskspace: 0 9055.795877176:main thread : action 8 queue: queue.highwatermark: -1 9055.795878555:main thread : action 8 queue: queue.lowwatermark: -1 9055.795879834:main thread : action 8 queue: queue.fulldelaymark: -1 9055.795881138:main thread : action 8 queue: queue.lightdelaymark: -1 9055.795882511:main thread : action 8 queue: queue.discardmark: 980 9055.795883834:main thread : action 8 queue: queue.discardseverity: 8 9055.795885174:main thread : action 8 queue: queue.checkpointinterval: 0 9055.795886505:main thread : action 8 queue: queue.syncqueuefiles: 0 9055.795887950:main thread : action 8 queue: queue.type: 3 [Direct] 9055.795889268:main thread : action 8 queue: queue.workerthreads: 1 9055.795890609:main thread : action 8 queue: queue.timeoutshutdown: 0 9055.795891979:main thread : action 8 queue: queue.timeoutactioncompletion: 1000 9055.795893299:main thread : action 8 queue: queue.timeoutenqueue: 50 9055.795894684:main thread : action 8 queue: queue.timeoutworkerthreadshutdown: 60000 9055.795896011:main thread : action 8 queue: queue.workerthreadminimummessages: -1 9055.795897387:main thread : action 8 queue: queue.maxfilesize: 1048576 9055.795898714:main thread : action 8 queue: queue.saveonshutdown: 1 9055.795900060:main thread : action 8 queue: queue.dequeueslowdown: 0 9055.795901376:main thread : action 8 queue: queue.dequeuetimebegin: 0 9055.795902698:main thread : action 8 queue: queue.dequeuetimeend: 25 9055.795904308:main thread : Action 0x2aa000d0ee0: queue 0x2aa000d12e0 created -> $$ = nterm s_act () Stack now 0 1 15 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 15 Entering state 23 Reading a token: Next token is token PRIFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 15 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 15 Entering state 35 Reducing stack by rule 31 (line 174): $1 = token PRIFILT () $2 = nterm block () 9055.795936772:main thread : Decoding traditional PRI filter 'mail.err' 9055.795938209:main thread : symbolic name: err ==> 3 9055.795940415:main thread : symbolic name: mail ==> 16 -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.795950504:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PRIFILT () Shifting token PRIFILT () Entering state 15 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.795966882:main thread : tried selector action for builtin:omfile: 0 9055.795968240:main thread : Module builtin:omfile processes this action. 9055.795969797:main thread : template: 'RSYSLOG_TraditionalFileFormat' assigned 9055.795973779:main thread : action 9 queue: parameter dump: 9055.795975125:main thread : action 9 queue: queue.filename '[NONE]' 9055.795976501:main thread : action 9 queue: queue.size: 1000 9055.795977876:main thread : action 9 queue: queue.dequeuebatchsize: 16 9055.795979279:main thread : action 9 queue: queue.maxdiskspace: 0 9055.795980635:main thread : action 9 queue: queue.highwatermark: -1 9055.795981985:main thread : action 9 queue: queue.lowwatermark: -1 9055.795983309:main thread : action 9 queue: queue.fulldelaymark: -1 9055.795984572:main thread : action 9 queue: queue.lightdelaymark: -1 9055.795985942:main thread : action 9 queue: queue.discardmark: 980 9055.795987227:main thread : action 9 queue: queue.discardseverity: 8 9055.795988581:main thread : action 9 queue: queue.checkpointinterval: 0 9055.795989936:main thread : action 9 queue: queue.syncqueuefiles: 0 9055.795991358:main thread : action 9 queue: queue.type: 3 [Direct] 9055.795992962:main thread : action 9 queue: queue.workerthreads: 1 9055.795994297:main thread : action 9 queue: queue.timeoutshutdown: 0 9055.795995646:main thread : action 9 queue: queue.timeoutactioncompletion: 1000 9055.795996991:main thread : action 9 queue: queue.timeoutenqueue: 50 9055.795998364:main thread : action 9 queue: queue.timeoutworkerthreadshutdown: 60000 9055.795999672:main thread : action 9 queue: queue.workerthreadminimummessages: -1 9055.796001079:main thread : action 9 queue: queue.maxfilesize: 1048576 9055.796002388:main thread : action 9 queue: queue.saveonshutdown: 1 9055.796003747:main thread : action 9 queue: queue.dequeueslowdown: 0 9055.796005086:main thread : action 9 queue: queue.dequeuetimebegin: 0 9055.796006428:main thread : action 9 queue: queue.dequeuetimeend: 25 9055.796008053:main thread : Action 0x2aa000d19e0: queue 0x2aa000d1de0 created -> $$ = nterm s_act () Stack now 0 1 15 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 15 Entering state 23 Reading a token: Next token is token PRIFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 15 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 15 Entering state 35 Reducing stack by rule 31 (line 174): $1 = token PRIFILT () $2 = nterm block () 9055.796040089:main thread : Decoding traditional PRI filter 'news.crit' 9055.796041579:main thread : symbolic name: crit ==> 2 9055.796043744:main thread : symbolic name: news ==> 56 -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.796053856:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PRIFILT () Shifting token PRIFILT () Entering state 15 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.796070153:main thread : tried selector action for builtin:omfile: 0 9055.796071516:main thread : Module builtin:omfile processes this action. 9055.796073082:main thread : template: 'RSYSLOG_TraditionalFileFormat' assigned 9055.796076055:main thread : action 10 queue: parameter dump: 9055.796077421:main thread : action 10 queue: queue.filename '[NONE]' 9055.796078805:main thread : action 10 queue: queue.size: 1000 9055.796080165:main thread : action 10 queue: queue.dequeuebatchsize: 16 9055.796081555:main thread : action 10 queue: queue.maxdiskspace: 0 9055.796082880:main thread : action 10 queue: queue.highwatermark: -1 9055.796084237:main thread : action 10 queue: queue.lowwatermark: -1 9055.796085555:main thread : action 10 queue: queue.fulldelaymark: -1 9055.796086852:main thread : action 10 queue: queue.lightdelaymark: -1 9055.796088256:main thread : action 10 queue: queue.discardmark: 980 9055.796089561:main thread : action 10 queue: queue.discardseverity: 8 9055.796090942:main thread : action 10 queue: queue.checkpointinterval: 0 9055.796092264:main thread : action 10 queue: queue.syncqueuefiles: 0 9055.796093683:main thread : action 10 queue: queue.type: 3 [Direct] 9055.796095018:main thread : action 10 queue: queue.workerthreads: 1 9055.796096377:main thread : action 10 queue: queue.timeoutshutdown: 0 9055.796097743:main thread : action 10 queue: queue.timeoutactioncompletion: 1000 9055.796099113:main thread : action 10 queue: queue.timeoutenqueue: 50 9055.796100482:main thread : action 10 queue: queue.timeoutworkerthreadshutdown: 60000 9055.796101809:main thread : action 10 queue: queue.workerthreadminimummessages: -1 9055.796103200:main thread : action 10 queue: queue.maxfilesize: 1048576 9055.796104510:main thread : action 10 queue: queue.saveonshutdown: 1 9055.796106114:main thread : action 10 queue: queue.dequeueslowdown: 0 9055.796107439:main thread : action 10 queue: queue.dequeuetimebegin: 0 9055.796108780:main thread : action 10 queue: queue.dequeuetimeend: 25 9055.796110401:main thread : Action 0x2aa000d24e0: queue 0x2aa000d28e0 created -> $$ = nterm s_act () Stack now 0 1 15 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 15 Entering state 23 Reading a token: Next token is token PRIFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 15 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 15 Entering state 35 Reducing stack by rule 31 (line 174): $1 = token PRIFILT () $2 = nterm block () 9055.796143758:main thread : Decoding traditional PRI filter 'news.err' 9055.796145183:main thread : symbolic name: err ==> 3 9055.796147379:main thread : symbolic name: news ==> 56 -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.796157498:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PRIFILT () Shifting token PRIFILT () Entering state 15 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.796173950:main thread : tried selector action for builtin:omfile: 0 9055.796175275:main thread : Module builtin:omfile processes this action. 9055.796177806:main thread : template: 'RSYSLOG_TraditionalFileFormat' assigned 9055.796180889:main thread : action 11 queue: parameter dump: 9055.796182279:main thread : action 11 queue: queue.filename '[NONE]' 9055.796183667:main thread : action 11 queue: queue.size: 1000 9055.796185014:main thread : action 11 queue: queue.dequeuebatchsize: 16 9055.796186426:main thread : action 11 queue: queue.maxdiskspace: 0 9055.796187780:main thread : action 11 queue: queue.highwatermark: -1 9055.796189147:main thread : action 11 queue: queue.lowwatermark: -1 9055.796190488:main thread : action 11 queue: queue.fulldelaymark: -1 9055.796191775:main thread : action 11 queue: queue.lightdelaymark: -1 9055.796193147:main thread : action 11 queue: queue.discardmark: 980 9055.796194423:main thread : action 11 queue: queue.discardseverity: 8 9055.796195794:main thread : action 11 queue: queue.checkpointinterval: 0 9055.796197104:main thread : action 11 queue: queue.syncqueuefiles: 0 9055.796198577:main thread : action 11 queue: queue.type: 3 [Direct] 9055.796199892:main thread : action 11 queue: queue.workerthreads: 1 9055.796201203:main thread : action 11 queue: queue.timeoutshutdown: 0 9055.796202558:main thread : action 11 queue: queue.timeoutactioncompletion: 1000 9055.796203893:main thread : action 11 queue: queue.timeoutenqueue: 50 9055.796205271:main thread : action 11 queue: queue.timeoutworkerthreadshutdown: 60000 9055.796206557:main thread : action 11 queue: queue.workerthreadminimummessages: -1 9055.796207981:main thread : action 11 queue: queue.maxfilesize: 1048576 9055.796209303:main thread : action 11 queue: queue.saveonshutdown: 1 9055.796210642:main thread : action 11 queue: queue.dequeueslowdown: 0 9055.796211966:main thread : action 11 queue: queue.dequeuetimebegin: 0 9055.796213329:main thread : action 11 queue: queue.dequeuetimeend: 25 9055.796214902:main thread : Action 0x2aa000d2fa0: queue 0x2aa000d33a0 created -> $$ = nterm s_act () Stack now 0 1 15 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 15 Entering state 23 Reading a token: Next token is token PRIFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 15 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 15 Entering state 35 Reducing stack by rule 31 (line 174): $1 = token PRIFILT () $2 = nterm block () 9055.796251985:main thread : Decoding traditional PRI filter 'news.notice' 9055.796253443:main thread : symbolic name: notice ==> 5 9055.796255711:main thread : symbolic name: news ==> 56 -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.796265892:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PRIFILT () Shifting token PRIFILT () Entering state 15 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.796282456:main thread : tried selector action for builtin:omfile: -2001 9055.796283989:main thread : tried selector action for builtin:ompipe: -2001 9055.796285653:main thread : tried selector action for builtin-shell: -2001 9055.796287229:main thread : tried selector action for builtin:omdiscard: -2001 9055.796288801:main thread : tried selector action for builtin:omfwd: -2001 9055.796290398:main thread : write-alltried selector action for builtin:omusrmsg: 0 9055.796292834:main thread : Module builtin:omusrmsg processes this action. 9055.796294442:main thread : template: ' WallFmt' assigned 9055.796298463:main thread : action 12 queue: parameter dump: 9055.796299842:main thread : action 12 queue: queue.filename '[NONE]' 9055.796301247:main thread : action 12 queue: queue.size: 1000 9055.796302584:main thread : action 12 queue: queue.dequeuebatchsize: 16 9055.796304002:main thread : action 12 queue: queue.maxdiskspace: 0 9055.796305392:main thread : action 12 queue: queue.highwatermark: -1 9055.796306789:main thread : action 12 queue: queue.lowwatermark: -1 9055.796308083:main thread : action 12 queue: queue.fulldelaymark: -1 9055.796309377:main thread : action 12 queue: queue.lightdelaymark: -1 9055.796310774:main thread : action 12 queue: queue.discardmark: 980 9055.796312085:main thread : action 12 queue: queue.discardseverity: 8 9055.796313485:main thread : action 12 queue: queue.checkpointinterval: 0 9055.796314807:main thread : action 12 queue: queue.syncqueuefiles: 0 9055.796316212:main thread : action 12 queue: queue.type: 3 [Direct] 9055.796317509:main thread : action 12 queue: queue.workerthreads: 1 9055.796318825:main thread : action 12 queue: queue.timeoutshutdown: 0 9055.796320176:main thread : action 12 queue: queue.timeoutactioncompletion: 1000 9055.796321546:main thread : action 12 queue: queue.timeoutenqueue: 50 9055.796322897:main thread : action 12 queue: queue.timeoutworkerthreadshutdown: 60000 9055.796324240:main thread : action 12 queue: queue.workerthreadminimummessages: -1 9055.796325626:main thread : action 12 queue: queue.maxfilesize: 1048576 9055.796326956:main thread : action 12 queue: queue.saveonshutdown: 1 9055.796328280:main thread : action 12 queue: queue.dequeueslowdown: 0 9055.796329509:main thread : action 12 queue: queue.dequeuetimebegin: 0 9055.796330666:main thread : action 12 queue: queue.dequeuetimeend: 25 9055.796332264:main thread : Action 0x2aa000d3930: queue 0x2aa000d3d30 created -> $$ = nterm s_act () Stack now 0 1 15 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 15 Entering state 23 Reading a token: Next token is token PRIFILT () Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 15 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 15 Entering state 35 Reducing stack by rule 31 (line 174): $1 = token PRIFILT () $2 = nterm block () 9055.796369554:main thread : Decoding traditional PRI filter '*.emerg' 9055.796371447:main thread : symbolic name: emerg ==> 0 -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.796381733:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Next token is token PRIFILT () Shifting token PRIFILT () Entering state 15 Reading a token: Next token is token LEGACY_ACTION () Shifting token LEGACY_ACTION () Entering state 13 Reducing stack by rule 38 (line 182): $1 = token LEGACY_ACTION () 9055.796397495:main thread : tried selector action for builtin:omfile: -2001 9055.796399455:main thread : tried selector action for builtin:ompipe: 0 9055.796400782:main thread : Module builtin:ompipe processes this action. 9055.796402444:main thread : template: 'RSYSLOG_FileFormat' assigned 9055.796405546:main thread : action 13 queue: parameter dump: 9055.796406946:main thread : action 13 queue: queue.filename '[NONE]' 9055.796408327:main thread : action 13 queue: queue.size: 1000 9055.796409680:main thread : action 13 queue: queue.dequeuebatchsize: 16 9055.796411090:main thread : action 13 queue: queue.maxdiskspace: 0 9055.796412443:main thread : action 13 queue: queue.highwatermark: -1 9055.796413829:main thread : action 13 queue: queue.lowwatermark: -1 9055.796415125:main thread : action 13 queue: queue.fulldelaymark: -1 9055.796416430:main thread : action 13 queue: queue.lightdelaymark: -1 9055.796417809:main thread : action 13 queue: queue.discardmark: 980 9055.796419105:main thread : action 13 queue: queue.discardseverity: 8 9055.796420479:main thread : action 13 queue: queue.checkpointinterval: 0 9055.796421793:main thread : action 13 queue: queue.syncqueuefiles: 0 9055.796423214:main thread : action 13 queue: queue.type: 3 [Direct] 9055.796424569:main thread : action 13 queue: queue.workerthreads: 1 9055.796425920:main thread : action 13 queue: queue.timeoutshutdown: 0 9055.796427308:main thread : action 13 queue: queue.timeoutactioncompletion: 1000 9055.796428643:main thread : action 13 queue: queue.timeoutenqueue: 50 9055.796430052:main thread : action 13 queue: queue.timeoutworkerthreadshutdown: 60000 9055.796431377:main thread : action 13 queue: queue.workerthreadminimummessages: -1 9055.796432798:main thread : action 13 queue: queue.maxfilesize: 1048576 9055.796434115:main thread : action 13 queue: queue.saveonshutdown: 1 9055.796435452:main thread : action 13 queue: queue.dequeueslowdown: 0 9055.796436809:main thread : action 13 queue: queue.dequeuetimebegin: 0 9055.796438168:main thread : action 13 queue: queue.dequeuetimeend: 25 9055.796439869:main thread : Action 0x2aa000d4410: queue 0x2aa000d4810 created -> $$ = nterm s_act () Stack now 0 1 15 Entering state 24 Reducing stack by rule 35 (line 178): $1 = nterm s_act () -> $$ = nterm actlst () Stack now 0 1 15 Entering state 23 Reading a token: 9055.796452834:main thread : config parser: reached end of file /etc/rsyslog.d/50-default.conf 9055.796454439:main thread : config parser: resume parsing of file /etc/rsyslog.conf at line 60 9055.796455790:main thread : config parser: reached end of file /etc/rsyslog.conf 9055.796456991:main thread : config parser: parsing completed Now at end of input. Reducing stack by rule 24 (line 159): $1 = nterm actlst () -> $$ = nterm stmt () Stack now 0 1 15 Entering state 34 Reducing stack by rule 33 (line 176): $1 = nterm stmt () -> $$ = nterm block () Stack now 0 1 15 Entering state 35 Reducing stack by rule 31 (line 174): $1 = token PRIFILT () $2 = nterm block () 9055.796476303:main thread : Decoding traditional PRI filter 'daemon.*;mail.*;news.err;*.=debug;*.=info;*.=notice;*.=warn' 9055.796477753:main thread : symbolic name: * ==> 255 9055.796480205:main thread : symbolic name: daemon ==> 24 9055.796482364:main thread : symbolic name: * ==> 255 9055.796484712:main thread : symbolic name: mail ==> 16 9055.796487357:main thread : symbolic name: err ==> 3 9055.796489526:main thread : symbolic name: news ==> 56 9055.796491837:main thread : symbolic name: debug ==> 7 9055.796494188:main thread : symbolic name: info ==> 6 9055.796496572:main thread : symbolic name: notice ==> 5 9055.796498895:main thread : symbolic name: warn ==> 4 -> $$ = nterm stmt () Stack now 0 1 Entering state 22 Reducing stack by rule 3 (line 129): $1 = nterm conf () $2 = nterm stmt () 9055.796509118:main thread : cnf:global:script -> $$ = nterm conf () Stack now 0 Entering state 1 Now at end of input. Shifting token $end () Entering state 2 Stack now 0 1 2 Cleanup: popping token $end () Cleanup: popping nterm conf () 9055.796522322:main thread : Number of actions in this configuration: 14 9055.796523608:main thread : begin ruleset optimization phase 9055.796525058:main thread : ruleset 'RSYSLOG_DefaultRuleset' before optimization: 9055.796526759:main thread : ruleset 0x2aa000b2750: rsyslog ruleset RSYSLOG_DefaultRuleset: 9055.796528487:main thread : PROPFILT 9055.796529809:main thread : Property.: 'syslogtag' 9055.796530956:main thread : Operation: 'startswith' 9055.796533120:main thread : Value....: 'juju-xnox-local-' 9055.796534315:main thread : THEN 9055.796535586:main thread : ACTION 0 [builtin:omfwd:@@10.245.232.4:6514;LongTagForwardFormat] 9055.796537729:main thread : END PROPFILT 9055.796539049:main thread : PROPFILT 9055.796540313:main thread : Property.: 'syslogtag' 9055.796541479:main thread : Operation: 'startswith' 9055.796543503:main thread : Value....: 'juju-xnox-local-' 9055.796544711:main thread : THEN 9055.796545797:main thread : ACTION 1 [builtin:omfwd:@@172.17.42.1:6514;LongTagForwardFormat] 9055.796547896:main thread : END PROPFILT 9055.796548931:main thread : PROPFILT 9055.796550122:main thread : Property.: 'syslogtag' 9055.796551264:main thread : Operation: 'startswith' 9055.796553245:main thread : Value....: 'juju-xnox-local-' 9055.796554331:main thread : THEN 9055.796555450:main thread : ACTION 2 [builtin:omfwd:@@192.168.122.1:6514;LongTagForwardFormat] 9055.796557400:main thread : END PROPFILT 9055.796558574:main thread : PROPFILT 9055.796559977:main thread : Property.: 'syslogtag' 9055.796561108:main thread : Operation: 'startswith' 9055.796563193:main thread : Value....: 'juju-xnox-local-' 9055.796564315:main thread : THEN 9055.796565491:main thread : STOP 9055.796567300:main thread : END PROPFILT 9055.796568602:main thread : PRIFILT 'auth,authpriv.*' 9055.796569825:main thread : pmask: X X X X FF X X X X X FF X X X X X X X X X X X X X X X 9055.796586868:main thread : ACTION 4 [builtin:omfile:/var/log/auth.log] 9055.796589171:main thread : END PRIFILT 9055.796590638:main thread : PRIFILT '*.*;auth,authpriv.none' 9055.796591744:main thread : pmask: FF FF FF FF X FF FF FF FF FF X FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 9055.796607646:main thread : ACTION 5 [builtin:omfile:-/var/log/syslog] 9055.796609549:main thread : END PRIFILT 9055.796610585:main thread : PRIFILT 'kern.*' 9055.796611545:main thread : pmask: FF X X X X X X X X X X X X X X X X X X X X X X X X X 9055.796628526:main thread : ACTION 6 [builtin:omfile:-/var/log/kern.log] 9055.796630612:main thread : END PRIFILT 9055.796631864:main thread : PRIFILT 'mail.*' 9055.796632959:main thread : pmask: X X FF X X X X X X X X X X X X X X X X X X X X X X X 9055.796650760:main thread : ACTION 7 [builtin:omfile:-/var/log/mail.log] 9055.796652832:main thread : END PRIFILT 9055.796654040:main thread : PRIFILT 'mail.err' 9055.796655120:main thread : pmask: X X F X X X X X X X X X X X X X X X X X X X X X X X 9055.796671952:main thread : ACTION 8 [builtin:omfile:/var/log/mail.err] 9055.796674008:main thread : END PRIFILT 9055.796675261:main thread : PRIFILT 'news.crit' 9055.796676366:main thread : pmask: X X X X X X X 7 X X X X X X X X X X X X X X X X X X 9055.796693208:main thread : ACTION 9 [builtin:omfile:/var/log/news/news.crit] 9055.796695278:main thread : END PRIFILT 9055.796696481:main thread : PRIFILT 'news.err' 9055.796697576:main thread : pmask: X X X X X X X F X X X X X X X X X X X X X X X X X X 9055.796714579:main thread : ACTION 10 [builtin:omfile:/var/log/news/news.err] 9055.796716683:main thread : END PRIFILT 9055.796717903:main thread : PRIFILT 'news.notice' 9055.796719021:main thread : pmask: X X X X X X X 3F X X X X X X X X X X X X X X X X X X 9055.796735966:main thread : ACTION 11 [builtin:omfile:-/var/log/news/news.notice] 9055.796738041:main thread : END PRIFILT 9055.796739252:main thread : PRIFILT '*.emerg' 9055.796740338:main thread : pmask: 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 9055.796759639:main thread : ACTION 12 [builtin:omusrmsg::omusrmsg:*] 9055.796761685:main thread : END PRIFILT 9055.796762933:main thread : PRIFILT 'daemon.*;mail.*;news.err;*.=debug;*.=info;*.=notice;*.=warn' 9055.796764061:main thread : pmask: F0 F0 FF FF F0 F0 F0 FF F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 9055.796782583:main thread : ACTION 13 [builtin:ompipe:|/dev/xconsole] 9055.796784671:main thread : END PRIFILT 9055.796786019:main thread : ruleset 0x2aa000b2750: ruleset RSYSLOG_DefaultRuleset assigned parser list: 9055.796788581:main thread : ruleset 'RSYSLOG_DefaultRuleset' after optimization: 9055.796789838:main thread : ruleset 0x2aa000b2750: rsyslog ruleset RSYSLOG_DefaultRuleset: 9055.796791079:main thread : PROPFILT 9055.796792338:main thread : Property.: 'syslogtag' 9055.796793450:main thread : Operation: 'startswith' 9055.796795423:main thread : Value....: 'juju-xnox-local-' 9055.796796568:main thread : THEN 9055.796797715:main thread : ACTION 0 [builtin:omfwd:@@10.245.232.4:6514;LongTagForwardFormat] 9055.796799816:main thread : END PROPFILT 9055.796800949:main thread : PROPFILT 9055.796802178:main thread : Property.: 'syslogtag' 9055.796803308:main thread : Operation: 'startswith' 9055.796805199:main thread : Value....: 'juju-xnox-local-' 9055.796806317:main thread : THEN 9055.796807388:main thread : ACTION 1 [builtin:omfwd:@@172.17.42.1:6514;LongTagForwardFormat] 9055.796809401:main thread : END PROPFILT 9055.796810561:main thread : PROPFILT 9055.796811762:main thread : Property.: 'syslogtag' 9055.796812916:main thread : Operation: 'startswith' 9055.796814822:main thread : Value....: 'juju-xnox-local-' 9055.796815946:main thread : THEN 9055.796817043:main thread : ACTION 2 [builtin:omfwd:@@192.168.122.1:6514;LongTagForwardFormat] 9055.796819080:main thread : END PROPFILT 9055.796820191:main thread : PROPFILT 9055.796821397:main thread : Property.: 'syslogtag' 9055.796822462:main thread : Operation: 'startswith' 9055.796824397:main thread : Value....: 'juju-xnox-local-' 9055.796825508:main thread : THEN 9055.796826635:main thread : STOP 9055.796828368:main thread : END PROPFILT 9055.796829588:main thread : PRIFILT 'auth,authpriv.*' 9055.796830688:main thread : pmask: X X X X FF X X X X X FF X X X X X X X X X X X X X X X 9055.796847745:main thread : ACTION 4 [builtin:omfile:/var/log/auth.log] 9055.796849815:main thread : END PRIFILT 9055.796851008:main thread : PRIFILT '*.*;auth,authpriv.none' 9055.796852070:main thread : pmask: FF FF FF FF X FF FF FF FF FF X FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 9055.796871234:main thread : ACTION 5 [builtin:omfile:-/var/log/syslog] 9055.796873494:main thread : END PRIFILT 9055.796874715:main thread : PRIFILT 'kern.*' 9055.796875860:main thread : pmask: FF X X X X X X X X X X X X X X X X X X X X X X X X X 9055.796892314:main thread : ACTION 6 [builtin:omfile:-/var/log/kern.log] 9055.796894307:main thread : END PRIFILT 9055.796895422:main thread : PRIFILT 'mail.*' 9055.796896484:main thread : pmask: X X FF X X X X X X X X X X X X X X X X X X X X X X X 9055.796913191:main thread : ACTION 7 [builtin:omfile:-/var/log/mail.log] 9055.796915129:main thread : END PRIFILT 9055.796916298:main thread : PRIFILT 'mail.err' 9055.796917552:main thread : pmask: X X F X X X X X X X X X X X X X X X X X X X X X X X 9055.796932629:main thread : ACTION 8 [builtin:omfile:/var/log/mail.err] 9055.796934457:main thread : END PRIFILT 9055.796935916:main thread : PRIFILT 'news.crit' 9055.796936905:main thread : pmask: X X X X X X X 7 X X X X X X X X X X X X X X X X X X 9055.796953454:main thread : ACTION 9 [builtin:omfile:/var/log/news/news.crit] 9055.796955667:main thread : END PRIFILT 9055.796956870:main thread : PRIFILT 'news.err' 9055.796957953:main thread : pmask: X X X X X X X F X X X X X X X X X X X X X X X X X X 9055.796974799:main thread : ACTION 10 [builtin:omfile:/var/log/news/news.err] 9055.796976869:main thread : END PRIFILT 9055.796978087:main thread : PRIFILT 'news.notice' 9055.796979215:main thread : pmask: X X X X X X X 3F X X X X X X X X X X X X X X X X X X 9055.796996289:main thread : ACTION 11 [builtin:omfile:-/var/log/news/news.notice] 9055.796998323:main thread : END PRIFILT 9055.796999552:main thread : PRIFILT '*.emerg' 9055.797000682:main thread : pmask: 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 9055.797019708:main thread : ACTION 12 [builtin:omusrmsg::omusrmsg:*] 9055.797021801:main thread : END PRIFILT 9055.797023040:main thread : PRIFILT 'daemon.*;mail.*;news.err;*.=debug;*.=info;*.=notice;*.=warn' 9055.797024127:main thread : pmask: F0 F0 FF FF F0 F0 F0 FF F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 9055.797042667:main thread : ACTION 13 [builtin:ompipe:|/dev/xconsole] 9055.797044707:main thread : END PRIFILT 9055.797045985:main thread : ruleset 0x2aa000b2750: ruleset RSYSLOG_DefaultRuleset assigned parser list: 9055.797047460:main thread : ruleset 'remote' before optimization: 9055.797049184:main thread : ruleset 0x2aa000cbcc0: rsyslog ruleset remote: 9055.797050434:main thread : PROPFILT 9055.797051689:main thread : Property.: 'syslogtag' 9055.797052820:main thread : Operation: 'startswith' 9055.797054924:main thread : Value....: 'juju-xnox-local-' 9055.797056010:main thread : THEN 9055.797057131:main thread : ACTION 3 [builtin:omfile::omfile:$logRotation;JujuLogFormat-xnox-local] 9055.797059233:main thread : END PROPFILT 9055.797060356:main thread : PROPFILT 9055.797061605:main thread : Property.: 'syslogtag' 9055.797062727:main thread : Operation: 'startswith' 9055.797064821:main thread : Value....: 'juju-xnox-local-' 9055.797065958:main thread : THEN 9055.797067091:main thread : STOP 9055.797068880:main thread : END PROPFILT 9055.797070122:main thread : ruleset 0x2aa000cbcc0: ruleset remote assigned parser list: 9055.797071647:main thread : ruleset 'remote' after optimization: 9055.797072872:main thread : ruleset 0x2aa000cbcc0: rsyslog ruleset remote: 9055.797074153:main thread : PROPFILT 9055.797075333:main thread : Property.: 'syslogtag' 9055.797076493:main thread : Operation: 'startswith' 9055.797078420:main thread : Value....: 'juju-xnox-local-' 9055.797079543:main thread : THEN 9055.797080623:main thread : ACTION 3 [builtin:omfile::omfile:$logRotation;JujuLogFormat-xnox-local] 9055.797082609:main thread : END PROPFILT 9055.797083728:main thread : PROPFILT 9055.797084939:main thread : Property.: 'syslogtag' 9055.797086057:main thread : Operation: 'startswith' 9055.797087954:main thread : Value....: 'juju-xnox-local-' 9055.797089432:main thread : THEN 9055.797090513:main thread : STOP 9055.797092278:main thread : END PROPFILT 9055.797093499:main thread : ruleset 0x2aa000cbcc0: ruleset remote assigned parser list: 9055.797094888:main thread : ruleset optimization phase finished. 9055.797096326:main thread : telling rsyslog core that config load for 0x2aa000af2b0 is done 9055.797098698:main thread : Timezone information table (0 entries): 9055.797100119:main thread : telling modules that config load for 0x2aa000af2b0 is done 9055.797101612:main thread : beginCnfLoad(0x2aa0005c728) for module 'builtin:omfile' 9055.797102865:main thread : calling endCnfLoad() for module 'builtin:omfile' 9055.797104395:main thread : beginCnfLoad(0x2aa0005f4f0) for module 'builtin:ompipe' 9055.797105628:main thread : calling endCnfLoad() for module 'builtin:ompipe' 9055.797107040:main thread : beginCnfLoad((nil)) for module 'builtin-shell' 9055.797108425:main thread : beginCnfLoad((nil)) for module 'builtin:omdiscard' 9055.797109810:main thread : beginCnfLoad(0x2aa00058ea0) for module 'builtin:omfwd' 9055.797111006:main thread : calling endCnfLoad() for module 'builtin:omfwd' 9055.797112406:main thread : beginCnfLoad((nil)) for module 'builtin:omusrmsg' 9055.797113756:main thread : beginCnfLoad((nil)) for module 'builtin:pmrfc5424' 9055.797115042:main thread : beginCnfLoad((nil)) for module 'builtin:pmrfc3164' 9055.797116340:main thread : beginCnfLoad((nil)) for module 'builtin:smfile' 9055.797117694:main thread : beginCnfLoad((nil)) for module 'builtin:smtradfile' 9055.797118993:main thread : beginCnfLoad((nil)) for module 'builtin:smfwd' 9055.797120276:main thread : beginCnfLoad((nil)) for module 'builtin:smtradfwd' 9055.797121634:main thread : beginCnfLoad(0x3fffd903190) for module 'imuxsock' 9055.797122819:main thread : calling endCnfLoad() for module 'imuxsock' 9055.797124319:main thread : beginCnfLoad(0x3fffd801fa8) for module 'imklog' 9055.797125529:main thread : calling endCnfLoad() for module 'imklog' 9055.797126982:main thread : beginCnfLoad(0x3fffd783228) for module 'imfile' 9055.797128147:main thread : calling endCnfLoad() for module 'imfile' 9055.797129711:main thread : imfile: opmode is 0, polling interval is 10 9055.797131145:main thread : beginCnfLoad(0x3fffd482358) for module 'imtcp' 9055.797132327:main thread : calling endCnfLoad() for module 'imtcp' 9055.797133727:main thread : telling modules to check config 0x2aa000af2b0 9055.797135270:main thread : module builtin:omfile tells us config can be activated 9055.797136670:main thread : module builtin:ompipe tells us config can be activated 9055.797137994:main thread : module builtin:omfwd tells us config can be activated 9055.797139370:main thread : module imuxsock tells us config can be activated 9055.797140688:main thread : module imklog tells us config can be activated 9055.797142132:main thread : module imfile tells us config can be activated 9055.797143623:main thread : module imtcp tells us config can be activated 9055.797144875:main thread : rsyslog finished loading master config 0x2aa000af2b0 9055.797146153:main thread : configuration object 0x2aa000af2b0 9055.797147318:main thread : Global Settings: 9055.797148553:main thread : bDebugPrintTemplateList.............: 1 9055.797149759:main thread : bDebugPrintModuleList : 0 9055.797150992:main thread : bDebugPrintCfSysLineHandlerList.....: 0 9055.797152229:main thread : bLogStatusMsgs : 1 9055.797153399:main thread : bErrMsgToStderr.....................: 1 9055.797154644:main thread : drop Msgs with malicious PTR Record : 0 9055.797155830:main thread : All Rulesets: 9055.797157178:main thread : ruleset 0x2aa000b2750: rsyslog ruleset RSYSLOG_DefaultRuleset: 9055.797158563:main thread : PROPFILT 9055.797159790:main thread : Property.: 'syslogtag' 9055.797160992:main thread : Operation: 'startswith' 9055.797163375:main thread : Value....: 'juju-xnox-local-' 9055.797164518:main thread : THEN 9055.797165638:main thread : ACTION 0 [builtin:omfwd:@@10.245.232.4:6514;LongTagForwardFormat] 9055.797167731:main thread : END PROPFILT 9055.797168902:main thread : PROPFILT 9055.797170077:main thread : Property.: 'syslogtag' 9055.797171134:main thread : Operation: 'startswith' 9055.797172986:main thread : Value....: 'juju-xnox-local-' 9055.797174041:main thread : THEN 9055.797175028:main thread : ACTION 1 [builtin:omfwd:@@172.17.42.1:6514;LongTagForwardFormat] 9055.797176948:main thread : END PROPFILT 9055.797178049:main thread : PROPFILT 9055.797179212:main thread : Property.: 'syslogtag' 9055.797180399:main thread : Operation: 'startswith' 9055.797182403:main thread : Value....: 'juju-xnox-local-' 9055.797183463:main thread : THEN 9055.797184507:main thread : ACTION 2 [builtin:omfwd:@@192.168.122.1:6514;LongTagForwardFormat] 9055.797186622:main thread : END PROPFILT 9055.797187798:main thread : PROPFILT 9055.797188957:main thread : Property.: 'syslogtag' 9055.797190044:main thread : Operation: 'startswith' 9055.797191966:main thread : Value....: 'juju-xnox-local-' 9055.797193102:main thread : THEN 9055.797194190:main thread : STOP 9055.797196067:main thread : END PROPFILT 9055.797197261:main thread : PRIFILT 'auth,authpriv.*' 9055.797198329:main thread : pmask: X X X X FF X X X X X FF X X X X X X X X X X X X X X X 9055.797214810:main thread : ACTION 4 [builtin:omfile:/var/log/auth.log] 9055.797216645:main thread : END PRIFILT 9055.797217709:main thread : PRIFILT '*.*;auth,authpriv.none' 9055.797218736:main thread : pmask: FF FF FF FF X FF FF FF FF FF X FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 9055.797236277:main thread : ACTION 5 [builtin:omfile:-/var/log/syslog] 9055.797238480:main thread : END PRIFILT 9055.797239696:main thread : PRIFILT 'kern.*' 9055.797240775:main thread : pmask: FF X X X X X X X X X X X X X X X X X X X X X X X X X 9055.797257579:main thread : ACTION 6 [builtin:omfile:-/var/log/kern.log] 9055.797259642:main thread : END PRIFILT 9055.797260888:main thread : PRIFILT 'mail.*' 9055.797262003:main thread : pmask: X X FF X X X X X X X X X X X X X X X X X X X X X X X 9055.797278730:main thread : ACTION 7 [builtin:omfile:-/var/log/mail.log] 9055.797280878:main thread : END PRIFILT 9055.797282114:main thread : PRIFILT 'mail.err' 9055.797283205:main thread : pmask: X X F X X X X X X X X X X X X X X X X X X X X X X X 9055.797301150:main thread : ACTION 8 [builtin:omfile:/var/log/mail.err] 9055.797303246:main thread : END PRIFILT 9055.797304446:main thread : PRIFILT 'news.crit' 9055.797305550:main thread : pmask: X X X X X X X 7 X X X X X X X X X X X X X X X X X X 9055.797322417:main thread : ACTION 9 [builtin:omfile:/var/log/news/news.crit] 9055.797324462:main thread : END PRIFILT 9055.797325676:main thread : PRIFILT 'news.err' 9055.797326801:main thread : pmask: X X X X X X X F X X X X X X X X X X X X X X X X X X 9055.797343726:main thread : ACTION 10 [builtin:omfile:/var/log/news/news.err] 9055.797345809:main thread : END PRIFILT 9055.797346995:main thread : PRIFILT 'news.notice' 9055.797348110:main thread : pmask: X X X X X X X 3F X X X X X X X X X X X X X X X X X X 9055.797364904:main thread : ACTION 11 [builtin:omfile:-/var/log/news/news.notice] 9055.797366964:main thread : END PRIFILT 9055.797368184:main thread : PRIFILT '*.emerg' 9055.797369310:main thread : pmask: 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 9055.797387930:main thread : ACTION 12 [builtin:omusrmsg::omusrmsg:*] 9055.797389961:main thread : END PRIFILT 9055.797391228:main thread : PRIFILT 'daemon.*;mail.*;news.err;*.=debug;*.=info;*.=notice;*.=warn' 9055.797392314:main thread : pmask: F0 F0 FF FF F0 F0 F0 FF F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 9055.797410632:main thread : ACTION 13 [builtin:ompipe:|/dev/xconsole] 9055.797412640:main thread : END PRIFILT 9055.797413922:main thread : ruleset 0x2aa000b2750: ruleset RSYSLOG_DefaultRuleset assigned parser list: 9055.797415309:main thread : ruleset 0x2aa000cbcc0: rsyslog ruleset remote: 9055.797416555:main thread : PROPFILT 9055.797417761:main thread : Property.: 'syslogtag' 9055.797418879:main thread : Operation: 'startswith' 9055.797420818:main thread : Value....: 'juju-xnox-local-' 9055.797421929:main thread : THEN 9055.797423052:main thread : ACTION 3 [builtin:omfile::omfile:$logRotation;JujuLogFormat-xnox-local] 9055.797425049:main thread : END PROPFILT 9055.797426201:main thread : PROPFILT 9055.797427389:main thread : Property.: 'syslogtag' 9055.797428504:main thread : Operation: 'startswith' 9055.797430391:main thread : Value....: 'juju-xnox-local-' 9055.797431560:main thread : THEN 9055.797432671:main thread : STOP 9055.797434431:main thread : END PROPFILT 9055.797435637:main thread : ruleset 0x2aa000cbcc0: ruleset remote assigned parser list: 9055.797437019:main thread : End of Rulesets. 9055.797438064:main thread : 9055.797439363:main thread : Template: Name='RSYSLOG_DebugFormat' 9055.797441482:main thread : Entry(2aa000b5220): type 1, (CONSTANT), value: 'Debug line with all properties: FROMHOST: '' 9055.797444280:main thread : Entry(2aa000b52e0): type 2, (FIELD), value: '7' 9055.797447003:main thread : Entry(2aa000b5450): type 1, (CONSTANT), value: '', fromhost-ip: '' 9055.797449952:main thread : Entry(2aa000b5510): type 2, (FIELD), value: '8' 9055.797452737:main thread : Entry(2aa000b5680): type 1, (CONSTANT), value: '', HOSTNAME: '' 9055.797455617:main thread : Entry(2aa000b5740): type 2, (FIELD), value: '3' 9055.797458433:main thread : Entry(2aa000b58b0): type 1, (CONSTANT), value: '', PRI: ' 9055.797460925:main thread : Entry(2aa000b5970): type 2, (FIELD), value: '9' 9055.797463589:main thread : Entry(2aa000b5ae0): type 1, (CONSTANT), value: ', syslogtag '' 9055.797466329:main thread : Entry(2aa000b5ba0): type 2, (FIELD), value: '4' 9055.797469022:main thread : Entry(2aa000b5d10): type 1, (CONSTANT), value: '', programname: '' 9055.797471665:main thread : Entry(2aa000b5dd0): type 2, (FIELD), value: '17' 9055.797474299:main thread : Entry(2aa000b5f40): type 1, (CONSTANT), value: '', APP-NAME: '' 9055.797477005:main thread : Entry(2aa000b6000): type 2, (FIELD), value: '20' 9055.797479678:main thread : Entry(2aa000b6170): type 1, (CONSTANT), value: '', PROCID: '' 9055.797482299:main thread : Entry(2aa000b6230): type 2, (FIELD), value: '21' 9055.797485109:main thread : Entry(2aa000b63a0): type 1, (CONSTANT), value: '', MSGID: '' 9055.797487808:main thread : Entry(2aa000b6460): type 2, (FIELD), value: '22' 9055.797490377:main thread : Entry(2aa000b65d0): type 1, (CONSTANT), value: '', TIMESTAMP: '' 9055.797492810:main thread : Entry(2aa000b6690): type 2, (FIELD), value: '2' 9055.797495305:main thread : Entry(2aa000b6800): type 1, (CONSTANT), value: '', STRUCTURED-DATA: '' 9055.797497873:main thread : Entry(2aa000b68c0): type 2, (FIELD), value: '19' 9055.797500372:main thread : Entry(2aa000b6a30): type 1, (CONSTANT), value: '', msg: '' 9055.797502963:main thread : Entry(2aa000b6af0): type 2, (FIELD), value: '1' 9055.797505255:main thread : Entry(2aa000b6c60): type 1, (CONSTANT), value: '' escaped msg: '' 9055.797507578:main thread : Entry(2aa000b6d20): type 2, (FIELD), value: '1' [drop control-characters] [COMPLEX] 9055.797511167:main thread : Entry(2aa000b6e90): type 1, (CONSTANT), value: '' inputname: ' 9055.797513416:main thread : Entry(2aa000b6f50): type 2, (FIELD), value: '6' 9055.797516074:main thread : Entry(2aa000b70c0): type 1, (CONSTANT), value: ' rawmsg: '' 9055.797518430:main thread : Entry(2aa000b7180): type 2, (FIELD), value: '5' 9055.797520968:main thread : Entry(2aa000b72f0): type 1, (CONSTANT), value: '' $!:' 9055.797524056:main thread : Entry(2aa000b73b0): type 2, (FIELD), value: '200' [EE-Property: '!'] 9055.797527839:main thread : Entry(2aa000b7540): type 1, (CONSTANT), value: ' $.:' 9055.797530540:main thread : Entry(2aa000b7600): type 2, (FIELD), value: '202' [Local Var: '!'] 9055.797533882:main thread : Entry(2aa000b7790): type 1, (CONSTANT), value: ' $/:' 9055.797536492:main thread : Entry(2aa000b7850): type 2, (FIELD), value: '203' 9055.797539183:main thread : Entry(2aa000b79e0): type 1, (CONSTANT), value: ' ' 9055.797541712:main thread : Template: Name='RSYSLOG_SyslogProtocol23Format' 9055.797543643:main thread : Entry(2aa000b7bd0): type 1, (CONSTANT), value: '<' 9055.797546267:main thread : Entry(2aa000b7c90): type 2, (FIELD), value: '9' 9055.797548931:main thread : Entry(2aa000b7e00): type 1, (CONSTANT), value: '>1 ' 9055.797551550:main thread : Entry(2aa000b7ec0): type 2, (FIELD), value: '2' [Format as RFC3339-Date] [COMPLEX] 9055.797555668:main thread : Entry(2aa000b8030): type 1, (CONSTANT), value: ' ' 9055.797558309:main thread : Entry(2aa000b80f0): type 2, (FIELD), value: '3' 9055.797560933:main thread : Entry(2aa000b8260): type 1, (CONSTANT), value: ' ' 9055.797563573:main thread : Entry(2aa000b8320): type 2, (FIELD), value: '20' 9055.797566259:main thread : Entry(2aa000b8490): type 1, (CONSTANT), value: ' ' 9055.797568856:main thread : Entry(2aa000b8550): type 2, (FIELD), value: '21' 9055.797571571:main thread : Entry(2aa000b86c0): type 1, (CONSTANT), value: ' ' 9055.797574207:main thread : Entry(2aa000b8780): type 2, (FIELD), value: '22' 9055.797576901:main thread : Entry(2aa000b88f0): type 1, (CONSTANT), value: ' ' 9055.797579549:main thread : Entry(2aa000b89b0): type 2, (FIELD), value: '19' 9055.797582232:main thread : Entry(2aa000b8b20): type 1, (CONSTANT), value: ' ' 9055.797584839:main thread : Entry(2aa000b8be0): type 2, (FIELD), value: '1' 9055.797587530:main thread : Entry(2aa000b8d50): type 1, (CONSTANT), value: ' ' 9055.797590058:main thread : Template: Name='RSYSLOG_FileFormat' 9055.797591879:main thread : Template: Name='RSYSLOG_TraditionalFileFormat' 9055.797593768:main thread : Template: Name=' WallFmt' 9055.797595730:main thread : Entry(2aa000b9060): type 1, (CONSTANT), value: ' Message from syslogd@' 9055.797598378:main thread : Entry(2aa000b9120): type 2, (FIELD), value: '3' 9055.797601060:main thread : Entry(2aa000b9290): type 1, (CONSTANT), value: ' at ' 9055.797603712:main thread : Entry(2aa000b9350): type 2, (FIELD), value: '16' 9055.797606387:main thread : Entry(2aa000b94c0): type 1, (CONSTANT), value: ' ... ' 9055.797609073:main thread : Entry(2aa000b9580): type 2, (FIELD), value: '4' 9055.797611707:main thread : Entry(2aa000b96f0): type 2, (FIELD), value: '1' 9055.797614385:main thread : Entry(2aa000b97d0): type 1, (CONSTANT), value: ' ' 9055.797616914:main thread : Template: Name='RSYSLOG_ForwardFormat' 9055.797618736:main thread : Template: Name='RSYSLOG_TraditionalForwardFormat' 9055.797620523:main thread : Template: Name=' StdUsrMsgFmt' 9055.797622450:main thread : Entry(2aa000b9ae0): type 1, (CONSTANT), value: ' ' 9055.797625137:main thread : Entry(2aa000b9ba0): type 2, (FIELD), value: '4' 9055.797627842:main thread : Entry(2aa000b9d10): type 2, (FIELD), value: '1' 9055.797630525:main thread : Entry(2aa000b9df0): type 1, (CONSTANT), value: ' ' 9055.797633053:main thread : Template: Name=' StdDBFmt' [SQL-Format (MySQL)] 9055.797635683:main thread : Entry(2aa000ba0d0): type 1, (CONSTANT), value: 'insert into SystemEvents (Message, Facility, FromHost, Priority, DeviceReportedTime, ReceivedAt, InfoUnitID, SysLogTag) values ('' 9055.797638690:main thread : Entry(2aa000ba190): type 2, (FIELD), value: '1' 9055.797641339:main thread : Entry(2aa000ba300): type 1, (CONSTANT), value: '', ' 9055.797644060:main thread : Entry(2aa000ba3c0): type 2, (FIELD), value: '12' 9055.797646737:main thread : Entry(2aa000ba530): type 1, (CONSTANT), value: ', '' 9055.797649384:main thread : Entry(2aa000ba5f0): type 2, (FIELD), value: '3' 9055.797652071:main thread : Entry(2aa000ba760): type 1, (CONSTANT), value: '', ' 9055.797654716:main thread : Entry(2aa000ba820): type 2, (FIELD), value: '14' 9055.797657373:main thread : Entry(2aa000ba990): type 1, (CONSTANT), value: ', '' 9055.797660027:main thread : Entry(2aa000baa50): type 2, (FIELD), value: '2' [Format as MySQL-Date] [COMPLEX] 9055.797663956:main thread : Entry(2aa000babc0): type 1, (CONSTANT), value: '', '' 9055.797666590:main thread : Entry(2aa000bac80): type 2, (FIELD), value: '16' [Format as MySQL-Date] [COMPLEX] 9055.797670548:main thread : Entry(2aa000badf0): type 1, (CONSTANT), value: '', ' 9055.797673151:main thread : Entry(2aa000baeb0): type 2, (FIELD), value: '11' 9055.797675920:main thread : Entry(2aa000bb020): type 1, (CONSTANT), value: ', '' 9055.797678520:main thread : Entry(2aa000bb0e0): type 2, (FIELD), value: '4' 9055.797681195:main thread : Entry(2aa000bb250): type 1, (CONSTANT), value: '')' 9055.797683741:main thread : Template: Name='RSYSLOG_SysklogdFileFormat' 9055.797685688:main thread : Entry(2aa000bb3b0): type 2, (FIELD), value: '2' 9055.797688315:main thread : Entry(2aa000bb520): type 1, (CONSTANT), value: ' ' 9055.797690955:main thread : Entry(2aa000bb5e0): type 2, (FIELD), value: '3' 9055.797693604:main thread : Entry(2aa000bb750): type 1, (CONSTANT), value: ' ' 9055.797696191:main thread : Entry(2aa000bb810): type 2, (FIELD), value: '4' 9055.797698869:main thread : Entry(2aa000bb980): type 2, (FIELD), value: '1' [SP iff no first SP] [COMPLEX] 9055.797702789:main thread : Entry(2aa000bba60): type 2, (FIELD), value: '1' 9055.797705427:main thread : Entry(2aa000bbb40): type 1, (CONSTANT), value: ' ' 9055.797708040:main thread : Template: Name=' StdPgSQLFmt' [SQL-Format (standard SQL)] 9055.797710655:main thread : Entry(2aa000bbe20): type 1, (CONSTANT), value: 'insert into SystemEvents (Message, Facility, FromHost, Priority, DeviceReportedTime, ReceivedAt, InfoUnitID, SysLogTag) values ('' 9055.797713376:main thread : Entry(2aa000bbee0): type 2, (FIELD), value: '1' 9055.797716066:main thread : Entry(2aa000bc050): type 1, (CONSTANT), value: '', ' 9055.797718745:main thread : Entry(2aa000bc110): type 2, (FIELD), value: '12' 9055.797721435:main thread : Entry(2aa000bc280): type 1, (CONSTANT), value: ', '' 9055.797724057:main thread : Entry(2aa000bc340): type 2, (FIELD), value: '3' 9055.797726727:main thread : Entry(2aa000bc4b0): type 1, (CONSTANT), value: '', ' 9055.797729426:main thread : Entry(2aa000bc570): type 2, (FIELD), value: '14' 9055.797732118:main thread : Entry(2aa000bc6e0): type 1, (CONSTANT), value: ', '' 9055.797734756:main thread : Entry(2aa000bc7a0): type 2, (FIELD), value: '2' [Format as PgSQL-Date] [COMPLEX] 9055.797738760:main thread : Entry(2aa000bc910): type 1, (CONSTANT), value: '', '' 9055.797741391:main thread : Entry(2aa000bc9d0): type 2, (FIELD), value: '16' [Format as PgSQL-Date] [COMPLEX] 9055.797745395:main thread : Entry(2aa000bcb40): type 1, (CONSTANT), value: '', ' 9055.797748029:main thread : Entry(2aa000bcc00): type 2, (FIELD), value: '11' 9055.797750742:main thread : Entry(2aa000bcd70): type 1, (CONSTANT), value: ', '' 9055.797753397:main thread : Entry(2aa000bce30): type 2, (FIELD), value: '4' 9055.797756076:main thread : Entry(2aa000bcfa0): type 1, (CONSTANT), value: '')' 9055.797758606:main thread : Template: Name=' StdJSONFmt' 9055.797760905:main thread : Entry(2aa000bd180): type 1, (CONSTANT), value: '{"message":"' 9055.797763580:main thread : Entry(2aa000bd240): type 2, (FIELD), value: '1' [format as JSON] [COMPLEX] 9055.797767582:main thread : Entry(2aa000bd3b0): type 1, (CONSTANT), value: '","fromhost":"' 9055.797770203:main thread : Entry(2aa000bd470): type 2, (FIELD), value: '3' [format as JSON] [COMPLEX] 9055.797774314:main thread : Entry(2aa000bd5e0): type 1, (CONSTANT), value: '","facility":"' 9055.797777353:main thread : Entry(2aa000bd6a0): type 2, (FIELD), value: '13' 9055.797780142:main thread : Entry(2aa000bd810): type 1, (CONSTANT), value: '","priority":"' 9055.797782829:main thread : Entry(2aa000bd8d0): type 2, (FIELD), value: '15' 9055.797785775:main thread : Entry(2aa000bda40): type 1, (CONSTANT), value: '","timereported":"' 9055.797788480:main thread : Entry(2aa000bdb00): type 2, (FIELD), value: '2' [Format as RFC3339-Date] [COMPLEX] 9055.797792424:main thread : Entry(2aa000bdc70): type 1, (CONSTANT), value: '","timegenerated":"' 9055.797795103:main thread : Entry(2aa000bdd30): type 2, (FIELD), value: '16' [Format as RFC3339-Date] [COMPLEX] 9055.797798894:main thread : Entry(2aa000bdea0): type 1, (CONSTANT), value: '"}' 9055.797801590:main thread : Template: Name='RSYSLOG_omudpspoofDfltSourceTpl' 9055.797803567:main thread : Entry(2aa000be000): type 2, (FIELD), value: '8' 9055.797806140:main thread : Template: Name='JujuLogFormat-xnox-local' 9055.797808003:main thread : Entry(2aa000c7610): type 2, (FIELD), value: '4' [substring, from character 17 to 9999999] [COMPLEX] 9055.797812021:main thread : Entry(2aa000c76d0): type 2, (FIELD), value: '1' [SP iff no first SP] [COMPLEX] 9055.797815904:main thread : Entry(2aa000c7840): type 2, (FIELD), value: '1' [drop last LF in msg] [COMPLEX] 9055.797819714:main thread : Entry(2aa000c7920): type 1, (CONSTANT), value: ' ' 9055.797822228:main thread : Template: Name='LongTagForwardFormat' 9055.797824169:main thread : Entry(2aa000c7b10): type 1, (CONSTANT), value: '<' 9055.797826683:main thread : Entry(2aa000c7bd0): type 2, (FIELD), value: '9' 9055.797828966:main thread : Entry(2aa000c7d40): type 1, (CONSTANT), value: '>' 9055.797831328:main thread : Entry(2aa000c7e00): type 2, (FIELD), value: '2' [Format as RFC3339-Date] [COMPLEX] 9055.797834716:main thread : Entry(2aa000c7f70): type 1, (CONSTANT), value: ' ' 9055.797837023:main thread : Entry(2aa000c8030): type 2, (FIELD), value: '3' 9055.797839416:main thread : Entry(2aa000c81a0): type 1, (CONSTANT), value: ' ' 9055.797841728:main thread : Entry(2aa000c8260): type 2, (FIELD), value: '4' 9055.797844277:main thread : Entry(2aa000c83d0): type 2, (FIELD), value: '1' [SP iff no first SP] [COMPLEX] 9055.797848608:main thread : Entry(2aa000c84b0): type 2, (FIELD), value: '1' 9055.797851454:main thread : Main queue size 100000 messages. 9055.797853133:main thread : Main queue worker threads: 2, wThread shutdown: 60000, Perists every 0 updates. 9055.797854733:main thread : Main queue timeouts: shutdown: 1500, action completion shutdown: 1000, enq: 2000 9055.797856504:main thread : Main queue watermarks: high: 80000, low: 20000, discard: 98000, discard-severity: 8 9055.797858011:main thread : Main queue save on shutdown 1, max disk space allowed 0 9055.797859355:main thread : Work Directory: '/var/spool/rsyslog'. 9055.797860618:main thread : Outchannel: Name='logRotation' 9055.797861877:main thread : File Template: '/var/log/juju-xnox-local/all-machines.log' 9055.797863141:main thread : Max Size.....: 536870912 9055.797864374:main thread : OnSizeLimtCmd: '/etc/juju-xnox-local/rsyslog/logrotate.run' 9055.797865560:main thread : Modules used in this configuration: 9055.797866818:main thread : builtin:omfile 9055.797867955:main thread : builtin:ompipe 9055.797869111:main thread : builtin-shell 9055.797870303:main thread : builtin:omdiscard 9055.797871862:main thread : builtin:omfwd 9055.797873017:main thread : builtin:omusrmsg 9055.797874173:main thread : builtin:pmrfc5424 9055.797875419:main thread : builtin:pmrfc3164 9055.797877059:main thread : builtin:smfile 9055.797878482:main thread : builtin:smtradfile 9055.797879815:main thread : builtin:smfwd 9055.797881079:main thread : builtin:smtradfwd 9055.797882253:main thread : imuxsock 9055.797883441:main thread : imklog 9055.797884579:main thread : imfile 9055.797885717:main thread : imtcp 9055.797887170:main thread : GenerateLocalHostName uses 'devac03' 9055.797889389:main thread : ratelimit:rsyslogd[dflt]:new ratelimiter:bReduceRepeatMsgs 1 9055.797891186:main thread : ratelimit:rsyslogd[internal_messages]:new ratelimiter:bReduceRepeatMsgs 1 9055.797895108:main thread : rsyslogd: checking if startup is ok, pidfile '/var/run/rsyslogd.pid'. 9055.797916323:main thread : rsyslogd: writing pidfile '/var/run/rsyslogd.pid'. 9055.797935775:main thread : umask set to 0022. 9055.797937415:main thread : telling modules to activate config (before dropping privs) 0x2aa000af2b0 9055.797939226:main thread : pre priv drop activating config 0x2aa000af2b0 for module imuxsock 9055.797940924:main thread : imuxsock: allocating memory for 0 listeners 9055.797947191:main thread : ratelimit:imuxsock:new ratelimiter:bReduceRepeatMsgs 1 9055.797964434:main thread : imuxsock: Opened UNIX socket '/run/systemd/journal/syslog' (fd 3). 9055.797966059:main thread : pre priv drop activating config 0x2aa000af2b0 for module imklog 9055.797972087:main thread : pre priv drop activating config 0x2aa000af2b0 for module imtcp 9055.797974179:main thread : tcpsrv: keep-alive set to 0 9055.797975432:main thread : tcpsrv: keep-alive interval set to 0 9055.797976734:main thread : tcpsrv: keep-alive probes set to 0 9055.797977984:main thread : tcpsrv: keep-alive timeout set to 0 9055.797979617:main thread : imtcp: trying to add port *:6514 9055.797982541:main thread : ratelimit:tcperver:new ratelimiter:bReduceRepeatMsgs 1 9055.797985944:main thread : caller requested object 'nsd_gtls', not found (iRet -3003) 9055.797987443:main thread : Requested to load module 'lmnsd_gtls' 9055.797989310:main thread : loading module '/usr/lib/rsyslog/lmnsd_gtls.so' 9055.834263164:main thread : source file nsd_gtls.c requested reference for module 'lmnet', reference count now 6 9055.834268152:main thread : caller requested object 'nsd_ptcp', not found (iRet -3003) 9055.834269539:main thread : Requested to load module 'lmnsd_ptcp' 9055.834271251:main thread : loading module '/usr/lib/rsyslog/lmnsd_ptcp.so' 9055.836218553:main thread : source file nsd_ptcp.c requested reference for module 'lmnetstrms', reference count now 6 9055.836225153:main thread : module lmnsd_ptcp of type 2 being loaded (keepType=0). 9055.836226505:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.836227506:main thread : entry point 'setModCnf' not present in module 9055.836228491:main thread : entry point 'getModCnfName' not present in module 9055.836229465:main thread : entry point 'beginCnfLoad' not present in module 9055.836231056:main thread : source file nsd_gtls.c requested reference for module 'lmnsd_ptcp', reference count now 1 9055.836236342:main thread : GTLS CA file: '/etc/juju-xnox-local/rsyslog/ca-cert.pem' 9055.836309246:main thread : source file nsdsel_gtls.c requested reference for module 'lmnsd_ptcp', reference count now 2 9055.836311619:main thread : module lmnsd_gtls of type 2 being loaded (keepType=1). 9055.836312772:main thread : entry point 'isCompatibleWithFeature' not present in module 9055.836313737:main thread : entry point 'setModCnf' not present in module 9055.836314696:main thread : entry point 'getModCnfName' not present in module 9055.836315653:main thread : entry point 'beginCnfLoad' not present in module 9055.836317254:main thread : source file netstrms.c requested reference for module 'lmnsd_gtls', reference count now 1 9055.836318934:main thread : GTLS certificate file: '/etc/juju-xnox-local/rsyslog/rsyslog-cert.pem' 9055.836319903:main thread : GTLS key file: '/etc/juju-xnox-local/rsyslog/rsyslog-key.pem' 9055.837446987:main thread : creating tcp listen socket on port 6514 9055.837514251:main thread : Allocating buffer for 10000 TCP sessions. 9055.837536290:main thread : setgroups(0, NULL): 0 9055.837538922:main thread : setgid(109): 0 9055.837542731:main thread : group privileges have been dropped to gid 109 9055.837587673:main thread : initgroups(syslog, 109): 0 9055.837591379:main thread : setuid(104): 0 9055.837594758:main thread : user privileges have been dropped to uid 104 9055.837595799:main thread : telling modules to activate config 0x2aa000af2b0 9055.837596960:main thread : activating config 0x2aa000af2b0 for module builtin:omfile 9055.837598007:main thread : activating config 0x2aa000af2b0 for module builtin:ompipe 9055.837599110:main thread : activating config 0x2aa000af2b0 for module builtin:omfwd 9055.837600235:main thread : activating config 0x2aa000af2b0 for module imuxsock 9055.837601243:main thread : activating config 0x2aa000af2b0 for module imklog 9055.837602316:main thread : activating config 0x2aa000af2b0 for module imfile 9055.837604358:main thread : ratelimit:imfile[/var/log/juju-xnox-local/machine-0.log]:new ratelimiter:bReduceRepeatMsgs 1 9055.837605541:main thread : activating config 0x2aa000af2b0 for module imtcp 9055.837607868:main thread : Allowed TCP Senders: 9055.837608767:main thread : No restrictions set. 9055.837609994:main thread : iterateAllActions calling into action 0x2aa000c9ae0 9055.837611206:main thread : action 0 queue: starting queue 9055.837613741:main thread : action 0 queue: is disk-assisted, disk will be used on demand 9055.837616886:main thread : action 0 queue: params: type 1, enq-only 0, disk assisted 1, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 450, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.837619528:main thread : action 0 queue:Reg: finalizing construction of worker thread pool (numworkerThreads 1) 9055.837621278:main thread : action 0 queue:Reg/w0: finalizing construction of worker instance data (for 14 actions) 9055.837623687:main thread : action 0 queue:DAwpool: finalizing construction of worker thread pool (numworkerThreads 1) 9055.837625029:main thread : action 0 queue:DAwpool/w0: finalizing construction of worker instance data (for 14 actions) 9055.837627008:main thread : action 0 queue[DA]: starting queue 9055.837628402:main thread : action 0 queue[DA]: .qi file name is '/var/spool/rsyslog/machine-0-xnox-local_0.qi', len 44 9055.837629554:main thread : action 0 queue[DA]: I am a child 9055.837633202:main thread : file stream /var/spool/rsyslog/machine-0-xnox-local_0.qi params: flush interval 0, async write 0 9055.837637464:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_0.qi' opened as #8 with mode 384 9055.837640767:main thread : strm 0x2aa00100690: opened file '/var/spool/rsyslog/machine-0-xnox-local_0.qi' for READ as 8 9055.837642961:main thread : strm 0x2aa00100690: file 8 read 572 bytes 9055.837653137:main thread : file stream machine-0-xnox-local_0 params: flush interval 0, async write 0 9055.837660388:main thread : file stream machine-0-xnox-local_0 params: flush interval 0, async write 0 9055.837662944:main thread : file stream machine-0-xnox-local_0 params: flush interval 0, async write 0 9055.837668167:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_0.00000076' opened as #9 with mode 384 9055.837669736:main thread : strm 0x2aa00100a10: opened file '/var/spool/rsyslog/machine-0-xnox-local_0.00000076' for WRITE as 9 9055.837670994:main thread : strm 0x2aa00100a10: file 9 seek, pos 1019021 9055.837674646:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_0.00000075' opened as #10 with mode 384 9055.837676438:main thread : strm 0x2aa00100c90: opened file '/var/spool/rsyslog/machine-0-xnox-local_0.00000075' for READ as 10 9055.837677578:main thread : strm 0x2aa00100c90: file 10 seek, pos 640331 9055.837680081:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_0.00000075' opened as #11 with mode 384 9055.837681677:main thread : strm 0x2aa00100f10: opened file '/var/spool/rsyslog/machine-0-xnox-local_0.00000075' for READ as 11 9055.837682756:main thread : strm 0x2aa00100f10: file 11 seek, pos 640331 9055.837684077:main thread : strm 0x2aa00100690: file 8(/var/spool/rsyslog/machine-0-xnox-local_0.qi) closing 9055.837687858:main thread : action 0 queue[DA]: params: type 2, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 0, lqsize 2591, pqsize 2591, child 1, full delay -1, light delay -1, deq batch size 8, high wtrmrk 0, low wtrmrk 1, discardmrk 0, max wrkr 1, min msgs f. wrkr 0 9055.837689914:main thread : action 0 queue[DA]:Reg: finalizing construction of worker thread pool (numworkerThreads 1) 9055.837691257:main thread : action 0 queue[DA]:Reg/w0: finalizing construction of worker instance data (for 14 actions) 9055.837692636:main thread : action 0 queue[DA]: queue finished initialization 9055.837693840:main thread : action 0 queue[DA]:Reg: high activity - starting 1 additional worker thread(s). 9055.837770553:main thread : action 0 queue[DA]:Reg: started with state 0, num workers now 1 9055.837773685:main thread : action 0 queue: DA queue initialized, disk queue 0x2aa00100310 9055.837774816:main thread : action 0 queue: queue finished initialization 9055.837777062:main thread : Action builtin:omfwd[0x2aa000c9ae0]: queue 0x2aa000c9ee0 started 9055.837778254:main thread : iterateAllActions calling into action 0x2aa000ca660 9055.837779167:main thread : action 1 queue: starting queue 9055.837780336:main thread : action 1 queue: is disk-assisted, disk will be used on demand 9055.837782916:3fffcdff910: thread created, tid 5479, name 'rs:action 0 queue[DA]:R' 9055.837800259:action 0 queue[DA]:Reg/w0: wti 0x2aa001007a0: worker starting 9055.837802293:action 0 queue[DA]:Reg/w0: DeleteProcessedBatch: we deleted 0 objects and enqueued 0 objects 9055.837803979:action 0 queue[DA]:Reg/w0: doDeleteBatch: delete batch from store, new sizes: log 2591, phys 2591 9055.837807565:main thread : action 1 queue: params: type 1, enq-only 0, disk assisted 1, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 450, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.837817841:main thread : action 1 queue:Reg: finalizing construction of worker thread pool (numworkerThreads 1) 9055.837819481:action 0 queue[DA]:Reg/w0: strm 0x2aa00100f10: file 11 read 4096 bytes 9055.837823380:main thread : action 1 queue:Reg/w0: finalizing construction of worker instance data (for 14 actions) 9055.837825779:main thread : action 1 queue:DAwpool: finalizing construction of worker thread pool (numworkerThreads 1) 9055.837827125:main thread : action 1 queue:DAwpool/w0: finalizing construction of worker instance data (for 14 actions) 9055.837830370:main thread : action 1 queue[DA]: starting queue 9055.837831876:main thread : action 1 queue[DA]: .qi file name is '/var/spool/rsyslog/machine-0-xnox-local_1.qi', len 44 9055.837832931:main thread : action 1 queue[DA]: I am a child 9055.837836012:main thread : file stream /var/spool/rsyslog/machine-0-xnox-local_1.qi params: flush interval 0, async write 0 9055.837839586:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_1.qi' opened as #8 with mode 384 9055.837841553:main thread : strm 0x2aa0011a090: opened file '/var/spool/rsyslog/machine-0-xnox-local_1.qi' for READ as 8 9055.837843524:main thread : strm 0x2aa0011a090: file 8 read 573 bytes 9055.837853120:main thread : file stream machine-0-xnox-local_1 params: flush interval 0, async write 0 9055.837861381:main thread : file stream machine-0-xnox-local_1 params: flush interval 0, async write 0 9055.837863901:main thread : file stream machine-0-xnox-local_1 params: flush interval 0, async write 0 9055.837868731:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_1.00000101' opened as #12 with mode 384 9055.837870293:main thread : strm 0x2aa0011b320: opened file '/var/spool/rsyslog/machine-0-xnox-local_1.00000101' for WRITE as 12 9055.837871539:main thread : strm 0x2aa0011b320: file 12 seek, pos 339142 9055.837874553:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_1.00000099' opened as #13 with mode 384 9055.837876215:main thread : strm 0x2aa0011c5b0: opened file '/var/spool/rsyslog/machine-0-xnox-local_1.00000099' for READ as 13 9055.837877318:main thread : strm 0x2aa0011c5b0: file 13 seek, pos 1009163 9055.837879731:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_1.00000099' opened as #14 with mode 384 9055.837881329:main thread : strm 0x2aa0011d840: opened file '/var/spool/rsyslog/machine-0-xnox-local_1.00000099' for READ as 14 9055.837882430:main thread : strm 0x2aa0011d840: file 14 seek, pos 1009163 9055.837883730:main thread : strm 0x2aa0011a090: file 8(/var/spool/rsyslog/machine-0-xnox-local_1.qi) closing 9055.837887205:main thread : action 1 queue[DA]: params: type 2, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 0, lqsize 2591, pqsize 2591, child 1, full delay -1, light delay -1, deq batch size 8, high wtrmrk 0, low wtrmrk 1, discardmrk 0, max wrkr 1, min msgs f. wrkr 0 9055.837889186:main thread : action 1 queue[DA]:Reg: finalizing construction of worker thread pool (numworkerThreads 1) 9055.837890665:main thread : action 1 queue[DA]:Reg/w0: finalizing construction of worker instance data (for 14 actions) 9055.837892048:main thread : action 1 queue[DA]: queue finished initialization 9055.837893237:main thread : action 1 queue[DA]:Reg: high activity - starting 1 additional worker thread(s). 9055.837896871:action 0 queue[DA]:Reg/w0: strm 0x2aa00100f10: file 11 read 4096 bytes 9055.837908290:action 0 queue[DA]:Reg/w0: action 'action 0': is transactional - executing in commit phase [New Thread 0x3fffcdff910 (LWP 5479)] 9055.837910028:action 0 queue[DA]:Reg/w0: wti 0x2aa001007a0: we need to create a new action worker instance for action 0 9055.837916821:action 0 queue[DA]:Reg/w0: DDDD: createWrkrInstance: pWrkrData 0x3fff8004500 9055.837918258:action 0 queue[DA]:Reg/w0: DDDD: writing data to table spot 0 9055.837919378:action 0 queue[DA]:Reg/w0: wti 0x2aa001007a0: created action worker instance 1 for action 0 9055.837920389:action 0 queue[DA]:Reg/w0: omfwd: beginTransaction 9055.837921378:action 0 queue[DA]:Reg/w0: 10.245.232.4 9055.837922266:action 0 queue[DA]:Reg/w0: TCPSendInit CREATE 9055.837926141:action 0 queue[DA]:Reg/w0: source file netstrms.c requested reference for module 'lmnsd_gtls', reference count now 2 9055.838186568:main thread : action 1 queue[DA]:Reg: started with state 0, num workers now 1 9055.838191545:main thread : action 1 queue: DA queue initialized, disk queue 0x2aa00119d50 9055.838192677:main thread : action 1 queue: queue finished initialization 9055.838194930:main thread : Action builtin:omfwd[0x2aa000ca660]: queue 0x2aa000caa20 started 9055.838196010:main thread : iterateAllActions calling into action 0x2aa000cb170 9055.838196925:main thread : action 2 queue: starting queue 9055.838198105:main thread : action 2 queue: is disk-assisted, disk will be used on demand 9055.838200772:main thread : action 2 queue: params: type 1, enq-only 0, disk assisted 1, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 450, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.838202715:main thread : action 2 queue:Reg: finalizing construction of worker thread pool (numworkerThreads 1) 9055.838204200:main thread : action 2 queue:Reg/w0: finalizing construction of worker instance data (for 14 actions) 9055.838207499:main thread : action 2 queue:DAwpool: finalizing construction of worker thread pool (numworkerThreads 1) 9055.838208949:main thread : action 2 queue:DAwpool/w0: finalizing construction of worker instance data (for 14 actions) 9055.838210771:main thread : action 2 queue[DA]: starting queue 9055.838212263:main thread : action 2 queue[DA]: .qi file name is '/var/spool/rsyslog/machine-0-xnox-local_2.qi', len 44 9055.838213264:main thread : action 2 queue[DA]: I am a child 9055.838217024:main thread : file stream /var/spool/rsyslog/machine-0-xnox-local_2.qi params: flush interval 0, async write 0 9055.838220829:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_2.qi' opened as #15 with mode 384 9055.838222649:main thread : strm 0x2aa0011fb00: opened file '/var/spool/rsyslog/machine-0-xnox-local_2.qi' for READ as 15 9055.838224711:main thread : strm 0x2aa0011fb00: file 15 read 571 bytes 9055.838234116:main thread : file stream machine-0-xnox-local_2 params: flush interval 0, async write 0 9055.838242568:main thread : file stream machine-0-xnox-local_2 params: flush interval 0, async write 0 9055.838244916:main thread : file stream machine-0-xnox-local_2 params: flush interval 0, async write 0 9055.838249427:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_2.00000155' opened as #16 with mode 384 9055.838250963:main thread : strm 0x2aa00120f00: opened file '/var/spool/rsyslog/machine-0-xnox-local_2.00000155' for WRITE as 16 9055.838252171:main thread : strm 0x2aa00120f00: file 16 seek, pos 522109 9055.838254818:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_2.00000155' opened as #17 with mode 384 9055.838256454:main thread : strm 0x2aa00122190: opened file '/var/spool/rsyslog/machine-0-xnox-local_2.00000155' for READ as 17 9055.838257557:main thread : strm 0x2aa00122190: file 17 seek, pos 109716 9055.838260041:main thread : file '/var/spool/rsyslog/machine-0-xnox-local_2.00000155' opened as #18 with mode 384 9055.838261577:main thread : strm 0x2aa00123420: opened file '/var/spool/rsyslog/machine-0-xnox-local_2.00000155' for READ as 18 9055.838262670:main thread : strm 0x2aa00123420: file 18 seek, pos 109716 9055.838263916:main thread : strm 0x2aa0011fb00: file 15(/var/spool/rsyslog/machine-0-xnox-local_2.qi) closing 9055.838267264:main thread : action 2 queue[DA]: params: type 2, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 0, lqsize 726, pqsize 726, child 1, full delay -1, light delay -1, deq batch size 8, high wtrmrk 0, low wtrmrk 1, discardmrk 0, max wrkr 1, min msgs f. wrkr 0 9055.838269104:main thread : action 2 queue[DA]:Reg: finalizing construction of worker thread pool (numworkerThreads 1) 9055.838270467:main thread : action 2 queue[DA]:Reg/w0: finalizing construction of worker instance data (for 14 actions) 9055.838271840:main thread : action 2 queue[DA]: queue finished initialization 9055.838273301:main thread : action 2 queue[DA]:Reg: high activity - starting 1 additional worker thread(s). [New Thread 0x3fff7fff910 (LWP 5480)] 9055.838768924:3fff7fff910: thread created, tid 5480, name 'rs:action 1 queue[DA]:R' 9055.838807185:action 1 queue[DA]:Reg/w0: wti 0x2aa0011a1a0: worker starting 9055.838811930:action 1 queue[DA]:Reg/w0: DeleteProcessedBatch: we deleted 0 objects and enqueued 0 objects 9055.838813302:action 1 queue[DA]:Reg/w0: doDeleteBatch: delete batch from store, new sizes: log 2591, phys 2591 9055.838843469:action 1 queue[DA]:Reg/w0: strm 0x2aa0011d840: file 14 read 4096 bytes 9055.838935240:action 1 queue[DA]:Reg/w0: strm 0x2aa0011d840: file 14 read 4096 bytes 9055.838956863:action 1 queue[DA]:Reg/w0: action 'action 1': is transactional - executing in commit phase 9055.838961170:action 1 queue[DA]:Reg/w0: wti 0x2aa0011a1a0: we need to create a new action worker instance for action 1 9055.838992631:action 1 queue[DA]:Reg/w0: DDDD: createWrkrInstance: pWrkrData 0x3fff0004390 9055.838997370:action 1 queue[DA]:Reg/w0: DDDD: writing data to table spot 0 9055.838998565:action 1 queue[DA]:Reg/w0: wti 0x2aa0011a1a0: created action worker instance 1 for action 1 9055.838999463:action 1 queue[DA]:Reg/w0: omfwd: beginTransaction 9055.839000391:action 1 queue[DA]:Reg/w0: 172.17.42.1 9055.839035564:action 1 queue[DA]:Reg/w0: TCPSendInit CREATE 9055.839038790:action 1 queue[DA]:Reg/w0: source file netstrms.c requested reference for module 'lmnsd_gtls', reference count now 3 9055.839279819:main thread : action 2 queue[DA]:Reg: started with state 0, num workers now 1 9055.839283976:main thread : action 2 queue: DA queue initialized, disk queue 0x2aa0011f7c0 9055.839305834:main thread : action 2 queue: queue finished initialization 9055.839309686:main thread : Action builtin:omfwd[0x2aa000cb170]: queue 0x2aa000cb570 started 9055.839310895:main thread : iterateAllActions calling into action 0x2aa000c5860 9055.839311817:main thread : action 4 queue: starting queue 9055.839314804:main thread : action 4 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839316106:main thread : Action builtin:omfile[0x2aa000c5860]: queue 0x2aa000c5c20 started 9055.839317164:main thread : iterateAllActions calling into action 0x2aa000c6320 9055.839318002:main thread : action 5 queue: starting queue 9055.839351405:main thread : action 5 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839354018:main thread : Action builtin:omfile[0x2aa000c6320]: queue 0x2aa000cf1e0 started 9055.839355088:main thread : iterateAllActions calling into action 0x2aa000cf8e0 9055.839355945:main thread : action 6 queue: starting queue 9055.839358414:main thread : action 6 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839359665:main thread : Action builtin:omfile[0x2aa000cf8e0]: queue 0x2aa000cfce0 started 9055.839360587:main thread : iterateAllActions calling into action 0x2aa000d03e0 9055.839361430:main thread : action 7 queue: starting queue 9055.839363876:main thread : action 7 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839365113:main thread : Action builtin:omfile[0x2aa000d03e0]: queue 0x2aa000d07e0 started 9055.839366044:main thread : iterateAllActions calling into action 0x2aa000d0ee0 9055.839366868:main thread : action 8 queue: starting queue 9055.839369315:main thread : action 8 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839370543:main thread : Action builtin:omfile[0x2aa000d0ee0]: queue 0x2aa000d12e0 started 9055.839371464:main thread : iterateAllActions calling into action 0x2aa000d19e0 9055.839372306:main thread : action 9 queue: starting queue 9055.839374747:main thread : action 9 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839375967:main thread : Action builtin:omfile[0x2aa000d19e0]: queue 0x2aa000d1de0 started 9055.839378808:3fff77ff910: thread created, tid 5481, name 'rs:action 2 queue[DA]:R' 9055.839391048:action 2 queue[DA]:Reg/w0: wti 0x2aa0011fc10: worker starting 9055.839392631:action 2 queue[DA]:Reg/w0: DeleteProcessedBatch: we deleted 0 objects and enqueued 0 objects [New Thread 0x3fff77ff910 (LWP 5481)] 9055.839479735:main thread : iterateAllActions calling into action 0x2aa000d24e0 9055.839482565:main thread : action 10 queue: starting queue 9055.839485642:main thread : action 10 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839487070:main thread : Action builtin:omfile[0x2aa000d24e0]: queue 0x2aa000d28e0 started 9055.839488120:main thread : iterateAllActions calling into action 0x2aa000d2fa0 9055.839489005:main thread : action 11 queue: starting queue 9055.839491588:main thread : action 11 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839492884:main thread : Action builtin:omfile[0x2aa000d2fa0]: queue 0x2aa000d33a0 started 9055.839493825:main thread : iterateAllActions calling into action 0x2aa000d3930 9055.839494674:main thread : action 12 queue: starting queue 9055.839497130:main thread : action 12 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839498392:main thread : Action builtin:omusrmsg[0x2aa000d3930]: queue 0x2aa000d3d30 started 9055.839499323:main thread : iterateAllActions calling into action 0x2aa000d4410 9055.839500147:main thread : action 13 queue: starting queue 9055.839502621:main thread : action 13 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839503880:main thread : Action builtin:ompipe[0x2aa000d4410]: queue 0x2aa000d4810 started 9055.839504936:main thread : iterateAllActions calling into action 0x2aa000cc200 9055.839505759:main thread : action 3 queue: starting queue 9055.839508200:main thread : action 3 queue: params: type 3, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 1000, lqsize 0, pqsize 0, child 0, full delay 970, light delay 700, deq batch size 16, high wtrmrk 900, low wtrmrk 700, discardmrk 980, max wrkr 1, min msgs f. wrkr 1000 9055.839509443:main thread : Action builtin:omfile[0x2aa000cc200]: queue 0x2aa000cc600 started 9055.839510769:main thread : Activating Ruleset Queue[(nil)] for Ruleset RSYSLOG_DefaultRuleset 9055.839511829:main thread : Activating Ruleset Queue[(nil)] for Ruleset remote 9055.839512942:main thread : activateMainQueue: mainq cnf obj ptr is (nil) 9055.839514653:main thread : main Q: starting queue 9055.839519039:main thread : main Q: is NOT disk-assisted 9055.839521586:main thread : main Q: params: type 0, enq-only 0, disk assisted 0, spoolDir '/var/spool/rsyslog', maxFileSz 1048576, maxQSize 100000, lqsize 0, pqsize 0, child 0, full delay 97000, light delay 70000, deq batch size 256, high wtrmrk 80000, low wtrmrk 20000, discardmrk 98000, max wrkr 2, min msgs f. wrkr 40000 9055.839523618:main thread : main Q:Reg: finalizing construction of worker thread pool (numworkerThreads 2) 9055.839525118:main thread : main Q:Reg/w0: finalizing construction of worker instance data (for 14 actions) 9055.839528077:main thread : main Q:Reg/w1: finalizing construction of worker instance data (for 14 actions) 9055.839530393:main thread : main Q: queue finished initialization 9055.839532394:main thread : Main processing queue is initialized and running 9055.839533875:main thread : running module imuxsock with config 0x2aa000c10d0, term mode: cooperative/SIGTTIN 9055.839602230:main thread : running module imklog with config 0x2aa000c2260, term mode: cancel 9055.839619419:3fff6fff910: thread created, tid 5482, name 'in:imuxsock' 9055.839625309:3fff6fff910: set thread name to 'in:imuxsock' 9055.839638999:imuxsock.c : --------imuxsock calling select, active file descriptors (max 3): 3 [New Thread 0x3fff6fff910 (LWP 5482)] 9055.839689119:main thread : running module imfile with config 0x2aa000c7460, term mode: cooperative/SIGTTIN 9055.839697634:3fff67ff910: thread created, tid 5483, name 'in:imklog' 9055.839699501:3fff67ff910: set thread name to 'in:imklog' 9055.839715818:imklog.c : imklog(BSD/Linux) waiting for kernel log line [New Thread 0x3fff67ff910 (LWP 5483)] 9055.839765176:main thread : running module imtcp with config 0x2aa000ce9b0, term mode: cooperative/SIGTTIN 9055.839792166:action 2 queue[DA]:Reg/w0: doDeleteBatch: delete batch from store, new sizes: log 726, phys 726 9055.839802306:3fff5fff910: thread created, tid 5484, name 'in:imfile' 9055.839804164:3fff5fff910: set thread name to 'in:imfile' [New Thread 0x3fff5fff910 (LWP 5484)] 9055.839815601:imfile.c : imfile: working in polling mode 9055.839820292:imfile.c : imfile: trying to open state for '/var/log/juju-xnox-local/machine-0.log', state file 'machine-0-xnox-local' 9055.839826983:imfile.c : file stream /var/spool/rsyslog/machine-0-xnox-local params: flush interval 0, async write 0 9055.839833860:imfile.c : file '/var/spool/rsyslog/machine-0-xnox-local' opened as #19 with mode 384 9055.839838227:imfile.c : strm 0x3ffe4002080: opened file '/var/spool/rsyslog/machine-0-xnox-local' for READ as 19 9055.839841478:imfile.c : strm 0x3ffe4002080: file 19 read 255 bytes 9055.839844636:main thread : configuration 0x2aa000af2b0 activated 9055.839850120:main thread : main Q: qqueueAdd: entry added, size now log 1, phys 1 entries 9055.839853290:main thread : main Q:Reg: high activity - starting 1 additional worker thread(s). 9055.839856752:imfile.c : file stream /var/log/juju-xnox-local/machine-0.log params: flush interval 0, async write 0 9055.839860299:imfile.c : imfile: deserialized state file, state file base name '/var/log/juju-xnox-local/machine-0.log', configured base name '/var/log/juju-xnox-local/machine-0.log' 9055.839863905:imfile.c : stream/after deserialize checking for file change on '/var/log/juju-xnox-local/machine-0.log', inode 129263/129263, size/currOffs 438587/434174 9055.839866878:imfile.c : file '/var/log/juju-xnox-local/machine-0.log' opened as #20 with mode 384 9055.839868916:imfile.c : strm 0x3ffe4003450: opened file '/var/log/juju-xnox-local/machine-0.log' for READ as 20 9055.839870279:imfile.c : strm 0x3ffe4003450: file 20 seek, pos 434174 9055.839871944:imfile.c : strm 0x3ffe4002080: file 19(/var/spool/rsyslog/machine-0-xnox-local) closing 9055.839876954:imfile.c : strm 0x3ffe4003450: file 20 read 4096 bytes 9055.839879653:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.network network.go:299 filtering "lxcbr0" address 10.0.3.1/24 for machine' [*ppCStr 0x3ffe4002300] 9055.839885923:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.network network.go:303 not filtering address local-cloud:172.17.42.1 for machine' [*ppCStr 0x3ffe4002300] [New Thread 0x3fff57ff910 (LWP 5485)] 9055.839889824:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.network network.go:303 not filtering address local-cloud:192.168.122.1 for machine' [*ppCStr 0x3ffe4002300] 9055.839893164:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.network network.go:303 not filtering address local-machine:::1 for machine' [*ppCStr 0x3ffe4002300] 9055.839897564:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.network network.go:307 addresses after filtering: [local-machine:127.0.0.1 local-cloud:10.245.232.4 local-cloud:172.17.42.1 local-cloud:192.168.122.1 local-machine:::1]' [*ppCStr 0x3ffe4002300] 9055.839902188:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 INFO juju.worker.machiner machiner.go:100 setting addresses for machine-0 to ["local-machine:127.0.0.1" "local-cloud:10.245.232.4" "local-cloud:172.17.42.1" "local-cloud:192.168.122.1" "local-machine:::1"]' [*ppCStr 0x3ffe4002300] 9055.839906198:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.apiserver apiserver.go:275 -> [1] machine-0 30.2ms {"RequestId":13,"Response":"'body redacted'"} Machiner[""].WatchAPIHostPorts' [*ppCStr 0x3ffe4002300] 9055.839909114:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.worker runner.go:196 "reboot" started' [*ppCStr 0x3ffe4002300] 9055.839913502:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.worker runner.go:196 "apiaddressupdater" started' [*ppCStr 0x3ffe4002300] 9055.839916308:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.worker runner.go:196 "rsyslog" started' [*ppCStr 0x3ffe4002300] 9055.839918934:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.worker runner.go:196 "diskmanager" started' [*ppCStr 0x3ffe4002300] 9055.839921579:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.worker runner.go:196 "networker" started' [*ppCStr 0x3ffe4002300] 9055.839924248:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 INFO juju.worker runner.go:275 stopped "networker", err: ' [*ppCStr 0x3ffe4002300] 9055.839926880:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.worker runner.go:203 "networker" done: ' [*ppCStr 0x3ffe4002300] 9055.839929768:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.worker runner.go:206 removing "networker" from known workers' [*ppCStr 0x3ffe4002300] 9055.839934705:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.apiserver apiserver.go:275 -> [1] machine-0 27.51ms {"RequestId":14,"Response":"'body redacted'"} Logger[""].LoggingConfig' [*ppCStr 0x3ffe4002300] 9055.839937442:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.container.kvm kvm.go:71 kvm-ok output:' [*ppCStr 0x3ffe4002300] 9055.839939651:imfile.c : DDDDD: readLine returns[0]: 'INFO: /dev/kvm exists' [*ppCStr 0x3ffe4002300] 9055.839941891:imfile.c : DDDDD: readLine returns[0]: 'KVM acceleration can be used' [*ppCStr 0x3ffe4002300] 9055.839944015:imfile.c : DDDDD: readLine returns[0]: '(null)' [*ppCStr 0x3ffe4002300] 9055.839946054:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.worker runner.go:196 "storageprovisioner-machine" started' [*ppCStr 0x3ffe4002300] 9055.839949777:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.apiserver apiserver.go:261 <- [1] machine-0 {"RequestId":18,"Type":"StorageProvisioner","Version":1,"Request":"WatchForEnvironConfigChanges","Params":"'params redacted'"}' [*ppCStr 0x3ffe4002300] 9055.839954641:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.apiserver apiserver.go:275 -> [1] machine-0 34.324ms {"RequestId":15,"Response":"'body redacted'"} Environment[""].WatchForEnvironConfigChanges' [*ppCStr 0x3ffe4002300] 9055.839957370:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.state open.go:57 connection established' [*ppCStr 0x3ffe4002300] 9055.839960245:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 INFO juju.mongo open.go:125 dialled mongo successfully on address "10.0.3.1:37017"' [*ppCStr 0x3ffe4002300] 9055.839963760:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.apiserver apiserver.go:261 <- [1] machine-0 {"RequestId":19,"Type":"Machiner","Request":"SetMachineAddresses","Params":"'params redacted'"}' [*ppCStr 0x3ffe4002300] 9055.839966980:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:44 DEBUG juju.worker.logger logger.go:45 reconfiguring logging from "=DEBUG" to "=WARNING;unit=DEBUG"' [*ppCStr 0x3ffe4002300] 9055.839971881:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:48 WARNING juju.worker.instanceupdater updater.go:251 cannot get instance info for instance "xnox-local-machine-1": localInstance.Addresses not implemented' [*ppCStr 0x3ffe4002300] 9055.839975511:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:51 WARNING juju.worker.instanceupdater updater.go:251 cannot get instance info for instance "xnox-local-machine-1": localInstance.Addresses not implemented' [*ppCStr 0x3ffe4002300] 9055.839979216:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:44:57 WARNING juju.worker.instanceupdater updater.go:251 cannot get instance info for instance "xnox-local-machine-1": localInstance.Addresses not implemented' [*ppCStr 0x3ffe4002300] 9055.839983027:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:45:05 WARNING juju.worker.instanceupdater updater.go:251 cannot get instance info for instance "xnox-local-machine-1": localInstance.Addresses not implemented' [*ppCStr 0x3ffe4002300] 9055.839986604:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:45:21 WARNING juju.worker.instanceupdater updater.go:251 cannot get instance info for instance "xnox-local-machine-1": localInstance.Addresses not implemented' [*ppCStr 0x3ffe4002300] 9055.839990206:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:45:54 WARNING juju.worker.instanceupdater updater.go:251 cannot get instance info for instance "xnox-local-machine-1": localInstance.Addresses not implemented' [*ppCStr 0x3ffe4002300] 9055.839994767:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:46:58 WARNING juju.worker.instanceupdater updater.go:251 cannot get instance info for instance "xnox-local-machine-1": localInstance.Addresses not implemented' [*ppCStr 0x3ffe4002300] 9055.839997901:imfile.c : strm 0x3ffe4003450: file 20 read 317 bytes 9055.840000693:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:49:06 WARNING juju.worker.instanceupdater updater.go:251 cannot get instance info for instance "xnox-local-machine-1": localInstance.Addresses not implemented' [*ppCStr 0x3ffe4002300] 9055.840004420:imfile.c : DDDDD: readLine returns[0]: '2016-01-27 23:53:22 WARNING juju.worker.instanceupdater updater.go:251 cannot get instance info for instance "xnox-local-machine-1": localInstance.Addresses not implemented' [*ppCStr 0x3ffe4002300] 9055.840006617:imfile.c : strm 0x3ffe4003450: file 20 read 0 bytes 9055.840009019:imfile.c : stream checking for file change on '/var/log/juju-xnox-local/machine-0.log', inode 129263/129263 9055.840010321:imfile.c : DDDDD: readLine returns[-2026]: '(null)' [*ppCStr 0x3ffe4002300] 9055.840016144:3fff57ff910: thread created, tid 5485, name 'in:imtcp' 9055.840017551:3fff57ff910: set thread name to 'in:imtcp' 9055.840109207:main thread : main Q:Reg: started with state 0, num workers now 1 9055.840112484:main thread : main Q: EnqueueMsg advised worker start 9055.840113855:main thread : rsyslogd: initialization completed, transitioning to regular run mode 9055.840115641:imfile.c : main Q: qqueueAdd: entry added, size now log 2, phys 2 entries 9055.840117583:imfile.c : main Q: qqueueAdd: entry added, size now log 3, phys 3 entries 9055.840118863:imfile.c : main Q: qqueueAdd: entry added, size now log 4, phys 4 entries 9055.840120113:imfile.c : main Q: qqueueAdd: entry added, size now log 5, phys 5 entries 9055.840121276:imfile.c : main Q: qqueueAdd: entry added, size now log 6, phys 6 entries 9055.840122464:imfile.c : main Q: qqueueAdd: entry added, size now log 7, phys 7 entries 9055.840123649:imfile.c : main Q: qqueueAdd: entry added, size now log 8, phys 8 entries 9055.840124822:imfile.c : main Q: qqueueAdd: entry added, size now log 9, phys 9 entries 9055.840126012:imfile.c : main Q: qqueueAdd: entry added, size now log 10, phys 10 entries 9055.840127188:imfile.c : main Q: qqueueAdd: entry added, size now log 11, phys 11 entries 9055.840128388:imfile.c : main Q: qqueueAdd: entry added, size now log 12, phys 12 entries 9055.840129560:imfile.c : main Q: qqueueAdd: entry added, size now log 13, phys 13 entries 9055.840130717:imfile.c : main Q: qqueueAdd: entry added, size now log 14, phys 14 entries 9055.840131868:imfile.c : main Q: qqueueAdd: entry added, size now log 15, phys 15 entries 9055.840133050:imfile.c : main Q: qqueueAdd: entry added, size now log 16, phys 16 entries 9055.840134204:imfile.c : main Q: qqueueAdd: entry added, size now log 17, phys 17 entries 9055.840135340:imfile.c : main Q: qqueueAdd: entry added, size now log 18, phys 18 entries 9055.840136496:imfile.c : main Q: qqueueAdd: entry added, size now log 19, phys 19 entries 9055.840137640:imfile.c : main Q: qqueueAdd: entry added, size now log 20, phys 20 entries [New Thread 0x3fff4fff910 (LWP 5486)] [New Thread 0x3fffc53b910 (LWP 5487)] 9055.840138794:imfile.c : main Q: qqueueAdd: entry added, size now log 21, phys 21 entries 9055.840140007:imfile.c : main Q: qqueueAdd: entry added, size now log 22, phys 22 entries 9055.840141154:imfile.c : main Q: qqueueAdd: entry added, size now log 23, phys 23 entries 9055.840142320:imfile.c : main Q: qqueueAdd: entry added, size now log 24, phys 24 entries 9055.840143451:imfile.c : main Q: qqueueAdd: entry added, size now log 25, phys 25 entries 9055.840144587:imfile.c : main Q: qqueueAdd: entry added, size now log 26, phys 26 entries 9055.840145706:imfile.c : main Q: qqueueAdd: entry added, size now log 27, phys 27 entries 9055.840146869:imfile.c : main Q: qqueueAdd: entry added, size now log 28, phys 28 entries 9055.840148013:imfile.c : main Q: qqueueAdd: entry added, size now log 29, phys 29 entries 9055.840149130:imfile.c : main Q: qqueueAdd: entry added, size now log 30, phys 30 entries 9055.840150261:imfile.c : main Q: qqueueAdd: entry added, size now log 31, phys 31 entries 9055.840151392:imfile.c : main Q: qqueueAdd: entry added, size now log 32, phys 32 entries 9055.840152517:imfile.c : main Q: qqueueAdd: entry added, size now log 33, phys 33 entries 9055.840153940:imfile.c : main Q: qqueueAdd: entry added, size now log 34, phys 34 entries 9055.840155086:imfile.c : main Q: qqueueAdd: entry added, size now log 35, phys 35 entries 9055.840156240:imfile.c : main Q: qqueueAdd: entry added, size now log 36, phys 36 entries 9055.840158238:imfile.c : main Q: MultiEnqObj advised worker start 9055.840160248:imfile.c : strm 0x3ffe4003450: file 20 read 0 bytes 9055.840164790:imfile.c : stream checking for file change on '/var/log/juju-xnox-local/machine-0.log', inode 129263/129263 9055.840166698:imfile.c : DDDDD: readLine returns[-2026]: '(null)' [*ppCStr 0x3ffe4002300] 9055.840167742:main thread : main Q: qqueueAdd: entry added, size now log 37, phys 37 entries 9055.840174666:main thread : main Q: EnqueueMsg advised worker start 9055.840176365:main thread : main Q: qqueueAdd: entry added, size now log 38, phys 38 entries 9055.840177431:main thread : main Q: EnqueueMsg advised worker start 9055.840178644:main thread : main Q: qqueueAdd: entry added, size now log 39, phys 39 entries 9055.840179651:main thread : main Q: EnqueueMsg advised worker start 9055.840183699:3fff4fff910: thread created, tid 5486, name 'rs:main Q:Reg' 9055.840194545:main Q:Reg/w0 : wti 0x2aa00120c80: worker starting 9055.840201369:main thread : main Q: qqueueAdd: entry added, size now log 40, phys 40 entries 9055.840206329:main thread : main Q: EnqueueMsg advised worker start 9055.840210387:main Q:Reg/w0 : DeleteProcessedBatch: we deleted 0 objects and enqueued 0 objects 9055.840211942:main Q:Reg/w0 : doDeleteBatch: delete batch from store, new sizes: log 40, phys 40 9055.840215025:main Q:Reg/w0 : processBATCH: batch of 40 elements must be processed 9055.840216486:main Q:Reg/w0 : processBATCH: next msg 0: [origin software="rsyslogd" swVersion="8.14.0" x-pid="5476" x-info="http://www.rsyslog.com"] start 9055.840219301:main Q:Reg/w0 : PROPFILT 9055.840221915:main Q:Reg/w0 : Property.: 'syslogtag' 9055.840224523:main Q:Reg/w0 : Operation: 'startswith' 9055.840227914:main Q:Reg/w0 : Value....: 'juju-xnox-local-' 9055.840231508:main Q:Reg/w0 : Filter: check for property 'syslogtag' (value 'rsyslogd:') startswith 'juju-xnox-local-': FALSE 9055.840233732:main Q:Reg/w0 : PROPFILT condition result is 0 9055.840234750:main Q:Reg/w0 : PROPFILT 9055.840250678:main Q:Reg/w0 : Property.: 'syslogtag' 9055.840253292:main Q:Reg/w0 : Operation: 'startswith' 9055.840256506:main Q:Reg/w0 : [New Thread 0x3fff47ff910 (LWP 5488)] Value....: 'juju-xnox-local-' 9055.840259383:main Q:Reg/w0 : Filter: check for property 'syslogtag' (value 'rsyslogd:') startswith 'juju-xnox-local-': FALSE 9055.840261477:main Q:Reg/w0 : PROPFILT condition result is 0 9055.840262696:main Q:Reg/w0 : PROPFILT 9055.840265192:main Q:Reg/w0 : Property.: 'syslogtag' 9055.840267701:main Q:Reg/w0 : Operation: 'startswith' 9055.840270945:main Q:Reg/w0 : Value....: 'juju-xnox-local-' 9055.840273674:main Q:Reg/w0 : Filter: check for property 'syslogtag' (value 'rsyslogd:') startswith 'juju-xnox-local-': FALSE 9055.840275687:main Q:Reg/w0 : PROPFILT condition result is 0 9055.840276764:main Q:Reg/w0 : PROPFILT 9055.840279193:main Q:Reg/w0 : Property.: 'syslogtag' 9055.840281682:main Q:Reg/w0 : Operation: 'startswith' 9055.840284902:main Q:Reg/w0 : Value....: 'juju-xnox-local-' 9055.840287836:main Q:Reg/w0 : Filter: check for property 'syslogtag' (value 'rsyslogd:') startswith 'juju-xnox-local-': FALSE 9055.840289855:main Q:Reg/w0 : PROPFILT condition result is 0 9055.840291077:main Q:Reg/w0 : PRIFILT 'auth,authpriv.*' 9055.840293638:main Q:Reg/w0 : pmask: X X X X FF X X X X X FF X X X X X X X X X X X X X X X 9055.840315193:main Q:Reg/w0 : PRIFILT condition result is 0 9055.840316425:main Q:Reg/w0 : PRIFILT '*.*;auth,authpriv.none' 9055.840319170:main Q:Reg/w0 : pmask: FF FF FF FF X FF FF FF FF FF X FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 9055.840341057:main Q:Reg/w0 : PRIFILT condition result is 1 9055.840342299:main Q:Reg/w0 : ACTION 5 [builtin:omfile:-/var/log/syslog] 9055.840345503:main Q:Reg/w0 : executing action 5 9055.840347372:main Q:Reg/w0 : action 'action 5': called, logging to builtin:omfile (susp 0/0, direct q 1) 9055.840349737:main Q:Reg/w0 : action 'action 5': is transactional - executing in commit phase 9055.840351276:main Q:Reg/w0 : wti 0x2aa00120c80: we need to create a new action worker instance for action 5 9055.840352777:main Q:Reg/w0 : DDDD: writing data to table spot 0 9055.840354243:main Q:Reg/w0 : wti 0x2aa00120c80: created action worker instance 1 for action 5 9055.840355671:main Q:Reg/w0 : Action 5 transitioned to state: itx 9055.840357267:main Q:Reg/w0 : action 'action 5': set suspended state to 0 9055.840358575:main Q:Reg/w0 : PRIFILT 'kern.*' 9055.840361136:main Q:Reg/w0 : pmask: FF X X X X X X X X X X X X X X X X X X X X X X X X X 9055.840382194:main Q:Reg/w0 : PRIFILT condition result is 0 9055.840383269:main Q:Reg/w0 : PRIFILT 'mail.*' 9055.840385754:main Q:Reg/w0 : pmask: X X FF X X X X X X X X X X X X X X X X X X X X X X X 9055.840406740:main Q:Reg/w0 : PRIFILT condition result is 0 9055.840407902:main Q:Reg/w0 : PRIFILT 'mail.err' 9055.840410428:main Q:Reg/w0 : pmask: X X F X X X X X X X X X X X X X X X X X X X X X X X 9055.840431510:main Q:Reg/w0 : PRIFILT condition result is 0 9055.840432697:main Q:Reg/w0 : PRIFILT 'news.crit' 9055.840435204:main Q:Reg/w0 : pmask: X X X X X X X 7 X X X X X X X X X X X X X X X X X X 9055.840456191:main Q:Reg/w0 : PRIFILT condition result is 0 9055.840457248:main Q:Reg/w0 : PRIFILT 'news.err' 9055.840459734:main Q:Reg/w0 : pmask: X X X X X X X F X X X X X X X X X X X X X X X X X X 9055.840480806:main Q:Reg/w0 : PRIFILT condition result is 0 9055.840481870:main Q:Reg/w0 : PRIFILT 'news.notice' 9055.840484364:main Q:Reg/w0 : pmask: X X X X X X X 3F X X X X X X X X X X X X X X X X X X 9055.840505377:main Q:Reg/w0 : PRIFILT condition result is 0 9055.840506498:main Q:Reg/w0 : PRIFILT '*.emerg' 9055.840509013:main Q:Reg/w0 : pmask: 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 9055.840531384:main Q:Reg/w0 : PRIFILT condition result is 0 9055.840532518:main Q:Reg/w0 : PRIFILT 'daemon.*;mail.*;news.err;*.=debug;*.=info;*.=notice;*.=warn' 9055.840535067:main Q:Reg/w0 : pmask: F0 F0 FF FF F0 F0 F0 FF F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 F0 9055.840557363:main Q:Reg/w0 : PRIFILT condition result is 1 9055.840558433:main Q:Reg/w0 : ACTION 13 [builtin:ompipe:|/dev/xconsole] 9055.840561321:main Q:Reg/w0 : executing action 13 9055.840562835:main Q:Reg/w0 : action 'action 13': called, logging to builtin:ompipe (susp 0/0, direct q 1) 9055.840564894:main Q:Reg/w0 : wti 0x2aa00120c80: we need to create a new action worker instance for action 13 9055.840566300:main Q:Reg/w0 : DDDD: writing data to table spot 0 9055.840567692:main Q:Reg/w0 : wti 0x2aa00120c80: created action worker instance 1 for action 13 9055.840569324:main Q:Reg/w0 : Action 13 transitioned to state: itx 9055.840570584:main Q:Reg/w0 : entering actionCalldoAction(), state: itx, actionNbr 13 9055.840572027:main Q:Reg/w0 : ompipe: writing to /dev/xconsole 9055.840581872:main Q:Reg/w0 : Called LogMsg, msg: Could not open output pipe '/dev/xconsole': 9055.840589440:main Q:Reg/w0 : main Q: qqueueAdd: entry added, size now log 1, phys 41 entries 9055.840590996:main Q:Reg/w0 : main Q: EnqueueMsg advised worker start rsyslogd: Could not open output pipe '/dev/xconsole':: No such file or directory [v8.14.0 try http://www.rsyslog.com/e/2039 ] 9055.840595528:main Q:Reg/w0 : Error opening log pipe: /dev/xconsole 9055.840596878:main Q:Reg/w0 : Action 13 transitioned to state: rtry 9055.840598252:main Q:Reg/w0 : action 'action 13': set suspended state to 1 9055.840599559:main Q:Reg/w0 : processBATCH: next msg 1: 2016-01-27 23:44:44 DEBUG juju.network network.go:299 filtering "lxcbr0" address 10.0.3.1/24 for machine 9055.840600650:main Q:Reg/w0 : PROPFILT 9055.840603107:main Q:Reg/w0 : Property.: 'syslogtag' 9055.840605652:main Q:Reg/w0 : Operation: 'startswith' 9055.840608923:main Q:Reg/w0 : Value....: 'juju-xnox-local-' 9055.840611831:main Q:Reg/w0 : Filter: check for property 'syslogtag' (value 'juju-xnox-local-machine-0:') startswith 'juju-xnox-local-': TRUE 9055.840613891:main Q:Reg/w0 : PROPFILT condition result is 1 9055.840614964:main Q:Reg/w0 : ACTION 0 [builtin:omfwd:@@10.245.232.4:6514;LongTagForwardFormat] 9055.840618072:main Q:Reg/w0 : executing action 0 9055.840619629:main Q:Reg/w0 : action 'action 0': called, logging to builtin:omfwd (susp 0/1, direct q 0) 9055.840621246:main Q:Reg/w0 : action 0 queue: qqueueAdd: entry added, size now log 1, phys 1 entries 9055.840622861:main Q:Reg/w0 : action 0 queue:Reg: high activity - starting 1 additional worker thread(s). 9055.840697236:main Q:Reg/w0 : action 0 queue:Reg: started with state 0, num workers now 1 9055.840700074:main Q:Reg/w0 : action 0 queue: EnqueueMsg advised worker start 9055.840701456:main Q:Reg/w0 : action 'action 0': set suspended state to 0 9055.840702747:main Q:Reg/w0 : PROPFILT 9055.840705003:main Q:Reg/w0 : Property.: 'syslogtag' 9055.840707333:main Q:Reg/w0 : Operation: 'startswith' 9055.840710377:main Q:Reg/w0 : Value....: 'juju-xnox-local-' 9055.840713017:main Q:Reg/w0 : Filter: check for property 'syslogtag' (value 'juju-xnox-local-machine-0:') startswith 'juju-xnox-local-': TRUE [New Thread 0x3fff43ff910 (LWP 5489)] [New Thread 0x3ffd7fff910 (LWP 5490)] 9055.840714954:main Q:Reg/w0 : PROPFILT condition result is 1 9055.840716026:main Q:Reg/w0 : ACTION 1 [builtin:omfwd:@@172.17.42.1:6514;LongTagForwardFormat] 9055.840718828:main Q:Reg/w0 : executing action 1 9055.840720465:main Q:Reg/w0 : action 'action 1': called, logging to builtin:omfwd (susp 0/0, direct q 0) 9055.840722002:main Q:Reg/w0 : action 1 queue: qqueueAdd: entry added, size now log 1, phys 1 entries 9055.840723585:main Q:Reg/w0 : action 1 queue:Reg: high activity - starting 1 additional worker thread(s). 9055.840746150:3ffd7fff910: thread created, tid 5490, name 'rs:action 0 queue:Reg' 9055.840767744:action 0 queue:Reg/w0: wti 0x2aa000f6f40: worker starting 9055.840769478:action 0 queue:Reg/w0: DeleteProcessedBatch: we deleted 0 objects and enqueued 0 objects 9055.840770938:action 0 queue:Reg/w0: doDeleteBatch: delete batch from store, new sizes: log 1, phys 1 9055.840773746:action 0 queue:Reg/w0: action 'action 0': is transactional - executing in commit phase 9055.840776292:action 0 queue:Reg/w0: wti 0x2aa000f6f40: we need to create a new action worker instance for action 0 9055.840782676:action 0 queue:Reg/w0: DDDD: createWrkrInstance: pWrkrData 0x3ffd00022a0 9055.840784457:action 0 queue:Reg/w0: DDDD: writing data to table spot 1 9055.840785967:action 0 queue:Reg/w0: wti 0x2aa000f6f40: created action worker instance 2 for action 0 9055.840787251:action 0 queue:Reg/w0: omfwd: beginTransaction 9055.840788608:action 0 queue:Reg/w0: 10.245.232.4 9055.840789915:action 0 queue:Reg/w0: TCPSendInit CREATE 9055.840795236:action 0 queue:Reg/w0: source file netstrms.c requested reference for module 'lmnsd_gtls', reference count now 4 9055.840881087:action 2 queue[DA]:Reg/w0: strm 0x2aa00123420: file 18 read 4096 bytes 9055.840953109:action 2 queue[DA]:Reg/w0: strm 0x2aa00123420: file 18 read 4096 bytes 9055.840963374:action 2 queue[DA]:Reg/w0: action 'action 2': is transactional - executing in commit phase 9055.840964682:action 2 queue[DA]:Reg/w0: wti 0x2aa0011fc10: we need to create a new action worker instance for action 2 9055.840971213:action 2 queue[DA]:Reg/w0: DDDD: createWrkrInstance: pWrkrData 0x3ffe8004660 9055.840972549:action 2 queue[DA]:Reg/w0: DDDD: writing data to table spot 0 9055.840973693:action 2 queue[DA]:Reg/w0: wti 0x2aa0011fc10: created action worker instance 1 for action 2 9055.840974566:action 2 queue[DA]:Reg/w0: omfwd: beginTransaction 9055.840975500:action 2 queue[DA]:Reg/w0: 192.168.122.1 9055.840976372:action 2 queue[DA]:Reg/w0: TCPSendInit CREATE 9055.840979961:action 2 queue[DA]:Reg/w0: source file netstrms.c requested reference for module 'lmnsd_gtls', reference count now 5 9055.841046605:main Q:Reg/w0 : action 1 queue:Reg: started with state 0, num workers now 1 9055.841048672:main Q:Reg/w0 : action 1 queue: EnqueueMsg advised worker start 9055.841050321:main Q:Reg/w0 : action 'action 1': set suspended state to 0 9055.841051529:main Q:Reg/w0 : PROPFILT 9055.841054134:main Q:Reg/w0 : Property.: 'syslogtag' 9055.841056986:main Q:Reg/w0 : Operation: 'startswith' 9055.841060490:main Q:Reg/w0 : Value....: 'juju-xnox-local-' [New Thread 0x3ffd77ff910 (LWP 5491)] [New Thread 0x3ffd6fff910 (LWP 5492)] 9055.841063927:main Q:Reg/w0 : Filter: check for property 'syslogtag' (value 'juju-xnox-local-machine-0:') startswith 'juju-xnox-local-': TRUE 9055.841066136:main Q:Reg/w0 : PROPFILT condition result is 1 9055.841067249:main Q:Reg/w0 : ACTION 2 [builtin:omfwd:@@192.168.122.1:6514;LongTagForwardFormat] 9055.841070302:main Q:Reg/w0 : executing action 2 9055.841072043:main Q:Reg/w0 : action 'action 2': called, logging to builtin:omfwd (susp 0/0, direct q 0) 9055.841073804:main Q:Reg/w0 : action 2 queue: qqueueAdd: entry added, size now log 1, phys 1 entries 9055.841075381:main Q:Reg/w0 : action 2 queue:Reg: high activity - starting 1 additional worker thread(s). 9055.841093178:imtcp.c : caller requested object 'nsdpoll_gtls', not found (iRet -3003) 9055.841096433:imtcp.c : tcpsrv could not use epoll() interface, iRet=-3003, using select() 9055.841099694:imtcp.c : hasRcvInBuffer on nsd 0x2aa00101700: pszRcvBuf (nil), lenRcvBuf 0 9055.841101258:imtcp.c : hasRcvInBuffer on nsd 0x2aa000f6870: pszRcvBuf (nil), lenRcvBuf 0 9055.841111334:imtcp.c : -------- calling select, active fds (max 7): 6 7 9055.841115923:imtcp.c : hasRcvInBuffer on nsd 0x2aa00101700: pszRcvBuf (nil), lenRcvBuf 0 9055.841117321:imtcp.c : hasRcvInBuffer on nsd 0x2aa000f6870: pszRcvBuf (nil), lenRcvBuf 0 9055.841127047:imtcp.c : tcpsrv: ready to process 1 event entries 9055.841128582:imtcp.c : tcpsrv: processing item 0, pUsr 0x2aa000fa680, bAbortConn 9055.841129747:imtcp.c : New connect on NSD 0x2aa000f6790. 9055.841136918:imtcp.c : dnscache: entry (nil) found 9055.841250459:3ffd77ff910: thread created, tid 5491, name 'rs:action 1 queue:Reg' 9055.841262247:action 1 queue:Reg/w0: wti 0x2aa00115aa0: worker starting 9055.841393269:action 1 queue:Reg/w0: DeleteProcessedBatch: we deleted 0 objects and enqueued 0 objects 9055.841395291:action 1 queue:Reg/w0: doDeleteBatch: delete batch from store, new sizes: log 1, phys 1 9055.841398483:action 1 queue:Reg/w0: action 'action 1': is transactional - executing in commit phase 9055.841403572:action 1 queue:Reg/w0: wti 0x2aa00115aa0: we need to create a new action worker instance for action 1 9055.841411709:action 1 queue:Reg/w0: DDDD: createWrkrInstance: pWrkrData 0x3ffc80022a0 9055.841416509:action 1 queue:Reg/w0: DDDD: writing data to table spot 1 9055.841418776:action 1 queue:Reg/w0: wti 0x2aa00115aa0: created action worker instance 2 for action 1 9055.841420689:action 1 queue:Reg/w0: omfwd: beginTransaction 9055.841422515:action 1 queue:Reg/w0: 172.17.42.1 9055.841424118:action 1 queue:Reg/w0: TCPSendInit CREATE 9055.841428666:action 1 queue:Reg/w0: source file netstrms.c requested reference for module 'lmnsd_gtls', reference count now 6 [New Thread 0x3ffd6bff910 (LWP 5493)] Program received signal SIGSEGV, Segmentation fault. [Switching to Thread 0x3fff57ff910 (LWP 5485)] gtlsClientCertCallback (session=, req_ca_rdn=, nreqs=, sign_algos=, sign_algos_length=0, st=0x3fff57fd1b8) at nsd_gtls.c:254 254 nsd_gtls.c: No such file or directory. (gdb) backtrace full #0 gtlsClientCertCallback (session=, req_ca_rdn=, nreqs=, sign_algos=, sign_algos_length=0, st=0x3fff57fd1b8) at nsd_gtls.c:254 pThis = 0x0 #1 0x000003fffd2358b4 in call_get_cert_callback (session=session@entry=0x3ffd8002ff0, issuers_dn=issuers_dn@entry=0x0, issuers_dn_length=issuers_dn_length@entry=0, pk_algos=pk_algos@entry=0x0, pk_algos_length=pk_algos_length@entry=0) at cert.c:483 i = local_certs = 0x0 local_key = 0x0 ret = -59 type = GNUTLS_CRT_X509 cred = st2 = {cert_type = GNUTLS_CRT_X509, key_type = GNUTLS_PRIVKEY_X509, cert = {x509 = 0x50, pgp = 0x50}, ncerts = 1, key = {x509 = 0x0, pgp = 0x0, pkcs11 = 0x0}, deinit_all = 0} pcert = 0x0 pcert_length = 0 #2 0x000003fffd236cda in _gnutls_server_select_cert (session=0x3ffd8002ff0, pk_algos=0x3fff57fd630, pk_algos_size=3) at cert.c:2015 i = j = idx = ret = cred = server_name = "\000\000\003\377\375\340\030\340\000\000\000\000\000\000\000m\000\000\003\377\375\340.(\000\000\003\377\375\377u\b\000\000\003\377\365\177Ӹ\000\000\003\377\365\177Ӵ\000\000\003\377\375\377u\b\000\000\003\377\330\000\000 \000\000\003\377\330\000\000x\000\000\000\000\000\000\000\000\000\000\003\377\375\261\346H\000\000\002\252\000\000\034P\000\000\000\000\000\000\000\005\000\000\000\000\000\000\000\001\000\000\000\000\000\207o\331\000\000\003\377\365\177\325\000\000\000\003\377\375\340\016\250\000\000\003\377\375\034\202\300\000\000\003\377\365\177\327\214\000\000\000\000\000\000A\260\000\000\000\000\000\000\000\005\000\000\003\377\330\000\000 \000\000\000\000\000\000A\244\000\000\003\377\375\261\340\000\000\000\003\377\375\255z(\000\000\003"... #3 0x000003fffd1ab534 in remove_unwanted_ciphersuites (session=session@entry=0x3ffd8002ff0, cipher_suites=cipher_suites@entry=0x3fff57fd6b0 "\300+\300,\300\206\300\207\300\t\300#\300\n\300$\300r\300s\300\b\300\a\300/\300\060\300\212\300\213\300\023\300'\300\024\300(\300v\300w\300\022\300\021", cipher_suites_size=, pk_algos=pk_algos@entry=0x3fff57fd630, pk_algos_size=pk_algos_size@entry=3) at gnutls_handshake.c:3416 ret = 0 i = new_suites_size = cert_cred = kx = server = 1 alg = {1023, 4118795744, 4025923138, 2170493580, 2465224492, GNUTLS_KX_SRP, 2078831564, 1879533729, 2189504532, 364164947, 3074207323, 2131444626, 1974209105, 1997322456, 482109447, 622609153, 1665503272, 313801553, 11459555, 3731221894, GNUTLS_KX_UNKNOWN, GNUTLS_KX_UNKNOWN, GNUTLS_KX_UNKNOWN, 249, 1023, 4118796208, 1023, 3623898132, 1096425877, 1312877806, 1023, 3623890928} alg_size = 32 #4 0x000003fffd1ac59c in _gnutls_server_select_suite (session=0x3ffd8002ff0, data=0x3ffd8008d85 "\300+\300,\300\206\300\207\300\t\300#\300\n\300$\300r\300s\300\b\300\a\300/\300\060\300\212\300\213\300\023\300'\300\024\300(\300v\300w\300\022\300\021", datalen=) at gnutls_handshake.c:957 ret = i = j = cipher_suites_size = pk_algos_size = 3 cipher_suites = "\300+\300,\300\206\300\207\300\t\300#\300\n\300$\300r\300s\300\b\300\a\300/\300\060\300\212\300\213\300\023\300'\300\024\300(\300v\300w\300\022\300\021\000\234\000\235\300z\300{\000/\000<\000\065\000=\000A\000\272\000\204\000\300\000\n\000\005\000\004\000\236\000\237\300|\300}\000\063\000g\000\071\000k\000E\000\276\000\210\000\304\000\026\000\242\000\243\300\200\300\201\000\062\000@\000\070\000j\000D\000\275\000\207\000\303\000\023\000f\000\000\000 \000\000\003\377\375)\327\b\000\000\000\032\375'>x\000\000\003\377\375&\002\003\000\256\333\343\336e\355\206\000\000\003\377\330\000\216\071\000\000\003\377\375\240\353\244\000\000\003\377\365\177\326\360\000\000\003\377\375\032\250\372"... retval = pk_algos = {GNUTLS_PK_EC, GNUTLS_PK_RSA, GNUTLS_PK_DSA, 105120, 1023, 3623916896, GNUTLS_PK_UNKNOWN, 68, 1023, 4256292864, 1023, 4256005008, 1023, 4255184836, 1023, 4118795760, GNUTLS_PK_UNKNOWN, 224, GNUTLS_PK_UNKNOWN, GNUTLS_PK_UNKNOWN, GNUTLS_PK_UNKNOWN, GNUTLS_PK_UNKNOWN, GNUTLS_PK_UNKNOWN, GNUTLS_PK_UNKNOWN, GNUTLS_PK_UNKNOWN, GNUTLS_PK_UNKNOWN, 1023, 51, 91, 110, 119, 124} #5 0x000003fffd1af518 in read_client_hello (datalen=, data=0x3ffd8008d60 "\003\003V\251Y\320\367y\270\065\005,C[\343\346\277W\375\345\377\261\326\340\311`%\313\f\r\202=\204\211", session=0x3ffd8002ff0) at gnutls_handshake.c:665 session_id_len = 0 '\000' pos = 171 comp_size = 1 neg_version = sret = suite_ptr = 0x3ffd8008d85 "\300+\300,\300\206\300\207\300\t\300#\300\n\300$\300r\300s\300\b\300\a\300/\300\060\300\212\300\213\300\023\300'\300\024\300(\300v\300w\300\022\300\021" comp_ptr = 0x3ffd8008e0a "" session_id = 0x3ffd8008d83 "" ret = adv_version = 0 len = 0 #6 recv_hello (datalen=, data=0x3ffd8008d60 "\003\003V\251Y\320\367y\270\065\005,C[\343\346\277W\375\345\377\261\326\340\311`%\313\f\r\202=\204\211", session=0x3ffd8002ff0) at gnutls_handshake.c:2248 No locals. #7 _gnutls_recv_handshake (session=0x3ffd8002ff0, type=, optional=, buf=0x0) at gnutls_handshake.c:1458 ret = hsk = {htype = GNUTLS_HANDSHAKE_CLIENT_HELLO, length = 245, sequence = 0, start_offset = 0, end_offset = 244, header = "\001\000\000\365\000\000\000\000\000\000\000", header_size = 4, data = {allocd = 0x3ffd8008d60 "\003\003V\251Y\320\367y\270\065\005,C[\343\346\277W\375\345\377\261\326\340\311`%\313\f\r\202=\204\211", data = 0x3ffd8008d60 "\003\003V\251Y\320\367y\270\065\005,C[\343\346\277W\375\345\377\261\326\340\311`%\313\f\r\202=\204\211", max_length = 2048, length = 245}} #8 0x000003fffd1b1864 in handshake_server (session=0x3ffd8002ff0) at gnutls_handshake.c:3086 ret = 0 #9 gnutls_handshake (session=0x3ffd8002ff0) at gnutls_handshake.c:2558 ret = params = 0x3ffd8004750 #10 0x000003fffd385406 in AcceptConnReq (pNsd=0x2aa00101700, ppNew=0x3fff57fde18) at nsd_gtls.c:1478 iRet = gnuRet = pNew = 0x3ffd8002c30 pThis = 0x2aa00101700 #11 0x000003fffd581a94 in AcceptConnReq (pThis=0x2aa000f6790, ppNew=0x3fff57fded0) at netstrm.c:119 pNewNsd = 0x0 iRet = RS_RET_OK #12 0x000003fffd40358c in SessAccept (pThis=pThis@entry=0x2aa000be570, pLstnInfo=0x2aa000be6e0, ppSess=ppSess@entry=0x3fff57fdfc8, pStrm=) at tcpsrv.c:440 iRet = RS_RET_OK pNewStrm = 0x0 iSess = -1 addr = 0x3ffd8002a40 fromHostFQDN = 0x0 fromHostIP = 0x3fff57fde70 #13 0x000003fffd4047ca in processWorksetItem (pUsr=, idx=, pPoll=0x0, pThis=0x2aa000be570) at tcpsrv.c:612 pNewSess = 0x0 iRet = RS_RET_OK #14 processWorkset (pThis=pThis@entry=0x2aa000be570, pPoll=pPoll@entry=0x0, numEntries=, numEntries@entry=1, workset=workset@entry=0x3fff57fe258) at tcpsrv.c:686 i = origEntries = 1 iRet = RS_RET_OK #15 0x000003fffd404dca in RunSelect (pThis=pThis@entry=0x2aa000be570, workset=workset@entry=0x3fff57fe258, sizeWorkset=128) at tcpsrv.c:821 __cancel_buf = {__cancel_jmp_buf = {{__cancel_jmp_buf = {{__gregs = {0, 4398000412904, 4393751543812, 4398000412344, 4397870342744, 4398000414376, 4398010974208, 2929168475504, 49214261308007546, 49214261441475190}, __fpregs = {4397870342736, 0, 2929168166940, 4397444098352, 0, 0, 0, 0}}}, __mask_was_saved = 0}}, __pad = {0x3fff57ff058, 0x0, 0x2aa000ceab0, 0x6c6d6e7364706f6c}} __cancel_arg = 0x3fff57fe0a8 __not_first_call = iRet = nfds = 0 i = iWorkset = 1 iTCPSess = -1 bIsReady = 0 pSel = 0x3ffd8002ab0 localRet = #16 0x000003fffd404f94 in Run (pThis=0x2aa000be570) at tcpsrv.c:883 iRet = RS_RET_OK i = workset = {{id = 0, pUsr = 0x2aa000fa680}, {id = 0, pUsr = 0x0}, {id = 0, pUsr = 0x0}, {id = 0, pUsr = 0x0} , {id = 0, pUsr = 0x3fff57feaa0}, {id = 0, pUsr = 0x0}, {id = 0, pUsr = 0x0}, {id = 0, pUsr = 0x0}, {id = 0, pUsr = 0x0}, {id = 0, pUsr = 0x0}, {id = 0, pUsr = 0x0}, {id = 0, pUsr = 0x0}, {id = 0, pUsr = 0x0}} numEntries = 0 pPoll = 0x3ffd80029c0 localRet = #17 0x000002aa0004cb36 in thrdStarter (arg=0x2aa00127360) at ../threads.c:212 iRet = RS_RET_OK pThis = 0x2aa00127360 thrdName = "in:imtcp", '\000' sigSet = {__val = {1048576, 0 }} #18 0x000003fffde079a2 in start_thread (arg=0x3fff57ff910) at pthread_create.c:335 pd = 0x3fff57ff910 unwind_buf = {cancel_jmp_buf = {{jmp_buf = {{__gregs = {4397870348560, 4397870348560, 4398046506335, 4397870346672, 1, 4397870348560, 4398010974208, 4398010942464, 49214261314295022, 49214261441462838}, __fpregs = {2929168166932, 0, 2929168166940, 4397444098352, 0, 0, 0, 0}}}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}} not_first_call = pagesize_m1 = sp = freesize = __PRETTY_FUNCTION__ = "start_thread" #19 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 No locals. (gdb) info registers r0 0x3fff57fd1b8 4397870338488 r1 0x50 80 r2 0x0 0 r3 0x0 0 r4 0x0 0 r5 0x0 0 r6 0x0 0 r7 0x3ffd8002ff0 4397375434736 r8 0x1 1 r9 0x0 0 r10 0x0 0 r11 0x0 0 r12 0x3fffde1c000 4398010974208 r13 0x3fff57fd1b8 4397870338488 r14 0x3fffd382f78 4397999861624 r15 0x3fff57fd048 4397870338120 pc 0x3fffd382f8e 0x3fffd382f8e cc 0x2 2 (gdb) x/16i $pc => 0x3fffd382f8e : lg %r1,88(%r2) 0x3fffd382f94 : lghi %r2,0 0x3fffd382f98 : stg %r1,24(%r13) 0x3fffd382f9e : mvhi 32(%r13),0 0x3fffd382fa4 : lg %r4,272(%r15) 0x3fffd382faa : lmg %r13,%r15,264(%r15) 0x3fffd382fb0 : br %r4 0x3fffd382fb2: nopr %r7 0x3fffd382fb4: nopr %r7 0x3fffd382fb6: nopr %r7 0x3fffd382fb8 : stmg %r9,%r15,72(%r15) 0x3fffd382fbe : ear %r1,%a0 0x3fffd382fc2 : sllg %r1,%r1,32 0x3fffd382fc8 : ear %r1,%a1 0x3fffd382fcc : lay %r15,-312(%r15) 0x3fffd382fd2 : lgr %r13,%r3 (gdb) thread apply all backtrace Thread 16 (Thread 0x3ffd6bff910 (LWP 5493)): #0 clone () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:47 #1 0x000003fffde065f6 in create_thread (pd=0x3ffd6bff910, attr=0x2aa0011afa8, stopped_start=, stackaddr=0x3ffd6bff1b0, thread_ran=0x3fff4ffe547) at ../sysdeps/unix/sysv/linux/createthread.c:102 #2 0x0000000000000000 in ?? () Backtrace stopped: previous frame inner to this frame (corrupt stack?) Thread 15 (Thread 0x3ffd6fff910 (LWP 5492)): #0 0x000003fffde0d65c in __pthread_cond_wait (cond=0x3fffd409e48 , mutex=0x3fffd409cd8 ) at pthread_cond_wait.c:186 #1 0x000003fffd404432 in wrkr (myself=0x3fffd409e40 ) at tcpsrv.c:644 #2 0x000003fffde079a2 in start_thread (arg=0x3ffd6fff910) at pthread_create.c:335 #3 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 14 (Thread 0x3ffd77ff910 (LWP 5491)): #0 recv () at ../sysdeps/unix/sysv/linux/s390/s390-64/socket.S:122 #1 0x000003fffd1a9c0a in _gnutls_stream_read (ms=0x3ffd77fe24c, pull_func=0x3fffd1c82c0 , size=5, bufel=, session=0x3ffc8006740) at gnutls_buffers.c:341 #2 _gnutls_read (ms=0x3ffd77fe24c, pull_func=0x3fffd1c82c0 , size=5, bufel=, session=0x3ffc8006740) at gnutls_buffers.c:421 #3 _gnutls_io_read_buffered (session=0x3ffc8006740, total=5, recv_type=, ms=0x3ffd77fe24c) at gnutls_buffers.c:564 #4 0x000003fffd1a458e in recv_headers (record_params=0x3ffc8007ac0, ms=0x3ffd77fe24c, record=0x3ffd77fe298, htype=, type=, session=0x3ffc8006740) at gnutls_record.c:1048 #5 _gnutls_recv_in_buffers (session=0x3ffc8006740, type=, htype=, ms=0) at gnutls_record.c:1177 #6 0x000003fffd1ab0ae in _gnutls_handshake_io_recv_int (session=0x3ffc8006740, htype=, hsk=0x3ffd77fe450, optional=) at gnutls_buffers.c:1389 #7 0x000003fffd1ae17a in _gnutls_recv_handshake (session=0x5a4f0a7290003, type=, optional=, buf=0x0) at gnutls_handshake.c:1419 #8 0x000003fffd1b0276 in handshake_client (session=) at gnutls_handshake.c:2715 #9 gnutls_handshake (session=0x3ffc8006740) at gnutls_handshake.c:2555 #10 0x000003fffd384fc2 in Connect (pNsd=0x3ffc8006600, family=, port=, host=0x2aa000ca4d0 "172.17.42.1") at nsd_gtls.c:1727 #11 0x000002aa0005ae40 in TCPSendInit (pvData=pvData@entry=0x3ffc80022a0) at omfwd.c:705 #12 0x000002aa0005af48 in doTryResume (pWrkrData=0x3ffc80022a0) at omfwd.c:762 #13 0x000002aa0004acb8 in actionPrepare (pWti=0x2aa00115aa0, pThis=0x2aa000ca660) at ../action.c:856 #14 processMsgMain (pAction=pAction@entry=0x2aa000ca660, pWti=pWti@entry=0x2aa00115aa0, pMsg=0x3ffe4002080, ttNow=ttNow@entry=0x3ffd77feb30) at ../action.c:1299 #15 0x000002aa0004aef8 in processBatchMain (pVoid=0x2aa000ca660, pBatch=0x2aa00115ad0, pWti=0x2aa00115aa0) at ../action.c:1335 #16 0x000002aa0003f46e in ConsumerReg (pThis=0x2aa000caa20, pWti=0x2aa00115aa0) at queue.c:1898 #17 0x000002aa0003b7fa in wtiWorker (pThis=0x2aa00115aa0) at wti.c:334 #18 0x000002aa0003a610 in wtpWorker (arg=0x2aa00115aa0) at wtp.c:389 #19 0x000003fffde079a2 in start_thread (arg=0x3ffd77ff910) at pthread_create.c:335 #20 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 13 (Thread 0x3ffd7fff910 (LWP 5490)): #0 recv () at ../sysdeps/unix/sysv/linux/s390/s390-64/socket.S:122 #1 0x000003fffd1a9c0a in _gnutls_stream_read (ms=0x3ffd7ffe24c, pull_func=0x3fffd1c82c0 , size=5, bufel=, session=0x3ffd0006740) at gnutls_buffers.c:341 #2 _gnutls_read (ms=0x3ffd7ffe24c, pull_func=0x3fffd1c82c0 , size=5, bufel=, session=0x3ffd0006740) at gnutls_buffers.c:421 #3 _gnutls_io_read_buffered (session=0x3ffd0006740, total=5, recv_type=, ms=0x3ffd7ffe24c) at gnutls_buffers.c:564 #4 0x000003fffd1a458e in recv_headers (record_params=0x3ffd0007ac0, ms=0x3ffd7ffe24c, record=0x3ffd7ffe298, htype=, type=, session=0x3ffd0006740) at gnutls_record.c:1048 #5 _gnutls_recv_in_buffers (session=0x3ffd0006740, type=, htype=, ms=0) at gnutls_record.c:1177 #6 0x000003fffd1ab0ae in _gnutls_handshake_io_recv_int (session=0x3ffd0006740, htype=, hsk=0x3ffd7ffe450, optional=) at gnutls_buffers.c:1389 #7 0x000003fffd1ae17a in _gnutls_recv_handshake (session=0x5a4f0a7290003, type=, optional=, buf=0x0) at gnutls_handshake.c:1419 #8 0x000003fffd1b0276 in handshake_client (session=) at gnutls_handshake.c:2715 #9 gnutls_handshake (session=0x3ffd0006740) at gnutls_handshake.c:2555 #10 0x000003fffd384fc2 in Connect (pNsd=0x3ffd0006600, family=, port=, host=0x2aa000c8950 "10.245.232.4") at nsd_gtls.c:1727 #11 0x000002aa0005ae40 in TCPSendInit (pvData=pvData@entry=0x3ffd00022a0) at omfwd.c:705 #12 0x000002aa0005af48 in doTryResume (pWrkrData=0x3ffd00022a0) at omfwd.c:762 #13 0x000002aa0004acb8 in actionPrepare (pWti=0x2aa000f6f40, pThis=0x2aa000c9ae0) at ../action.c:856 #14 processMsgMain (pAction=pAction@entry=0x2aa000c9ae0, pWti=pWti@entry=0x2aa000f6f40, pMsg=0x3ffe4002080, ttNow=ttNow@entry=0x3ffd7ffeb30) at ../action.c:1299 #15 0x000002aa0004aef8 in processBatchMain (pVoid=0x2aa000c9ae0, pBatch=0x2aa000f6f70, pWti=0x2aa000f6f40) at ../action.c:1335 #16 0x000002aa0003f46e in ConsumerReg (pThis=0x2aa000c9ee0, pWti=0x2aa000f6f40) at queue.c:1898 #17 0x000002aa0003b7fa in wtiWorker (pThis=0x2aa000f6f40) at wti.c:334 #18 0x000002aa0003a610 in wtpWorker (arg=0x2aa000f6f40) at wtp.c:389 #19 0x000003fffde079a2 in start_thread (arg=0x3ffd7fff910) at pthread_create.c:335 #20 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 12 (Thread 0x3fff43ff910 (LWP 5489)): #0 0x000003fffde0d65c in __pthread_cond_wait (cond=0x3fffd409de0 , mutex=0x3fffd409cd8 ) at pthread_cond_wait.c:186 #1 0x000003fffd404432 in wrkr (myself=0x3fffd409dd8 ) at tcpsrv.c:644 #2 0x000003fffde079a2 in start_thread (arg=0x3fff43ff910) at pthread_create.c:335 #3 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 11 (Thread 0x3fff47ff910 (LWP 5488)): #0 0x000003fffde0d65c in __pthread_cond_wait (cond=0x3fffd409d78 , mutex=0x3fffd409cd8 ) at pthread_cond_wait.c:186 #1 0x000003fffd404432 in wrkr (myself=0x3fffd409d70 ) at tcpsrv.c:644 #2 0x000003fffde079a2 in start_thread (arg=0x3fff47ff910) at pthread_create.c:335 #3 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 10 (Thread 0x3fffc53b910 (LWP 5487)): #0 0x000003fffde0d65c in __pthread_cond_wait (cond=0x3fffd409d10 , mutex=0x3fffd409cd8 ) at pthread_cond_wait.c:186 #1 0x000003fffd404432 in wrkr (myself=0x3fffd409d08 ) at tcpsrv.c:644 #2 0x000003fffde079a2 in start_thread (arg=0x3fffc53b910) at pthread_create.c:335 #3 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 9 (Thread 0x3fff4fff910 (LWP 5486)): #0 clone () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:47 #1 0x000003fffde065f6 in create_thread (pd=0x3ffd6bff910, pd@entry=0x1, attr=attr@entry=0x2aa0011afa8, stopped_start=, stopped_start@entry=false, stackaddr=0x3ffd6bff1b0, thread_ran=thread_ran@entry=0x3fff4ffe547) at ../sysdeps/unix/sysv/linux/createthread.c:102 #2 0x000003fffde08136 in __pthread_create_2_1 (newthread=, attr=, start_routine=, arg=) at pthread_create.c:677 #3 0x000002aa0003aed8 in wtpStartWrkr (pThis=0x2aa0011af10) at wtp.c:433 #4 wtpAdviseMaxWorkers (pThis=0x2aa0011af10, nMaxWrkr=) at wtp.c:476 #5 0x000002aa0004080c in qqueueAdviseMaxWorkers (pThis=0x2aa000cb570) at queue.c:369 #6 qqueueEnqMsg (pThis=0x2aa000cb570, flowCtlType=, pMsg=) at queue.c:2868 #7 0x000002aa0004aff8 in doSubmitToActionQ (pAction=0x2aa000cb170, pWti=0x2aa00120c80, pMsg=0x3ffe4002080) at ../action.c:1456 #8 0x000002aa000439d2 in execAct (stmt=0x2aa000caf10, pWti=, pMsg=) at ruleset.c:202 #9 scriptExec (root=, pMsg=pMsg@entry=0x3ffe4002080, pWti=pWti@entry=0x2aa00120c80) at ruleset.c:455 #10 0x000002aa00043a60 in execPROPFILT (pWti=, pMsg=, stmt=0x2aa000cb0e0) at ruleset.c:422 #11 scriptExec (root=, pMsg=0x3ffe4002080, pWti=0x2aa00120c80) at ruleset.c:476 #12 0x000002aa00044034 in processBatch (pBatch=0x2aa00120cb0, pWti=0x2aa00120c80) at ruleset.c:509 #13 0x000002aa00054332 in msgConsumer (notNeeded=, pBatch=0x2aa00120cb0, pWti=) at rsyslogd.c:575 #14 0x000002aa0003f46e in ConsumerReg (pThis=0x2aa001246b0, pWti=0x2aa00120c80) at queue.c:1898 #15 0x000002aa0003b7fa in wtiWorker (pThis=0x2aa00120c80) at wti.c:334 #16 0x000002aa0003a610 in wtpWorker (arg=0x2aa00120c80) at wtp.c:389 #17 0x000003fffde079a2 in start_thread (arg=0x3fff4fff910) at pthread_create.c:335 #18 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 8 (Thread 0x3fff57ff910 (LWP 5485)): #0 gtlsClientCertCallback (session=, req_ca_rdn=, nreqs=, sign_algos=, sign_algos_length=0, st=0x3fff57fd1b8) at nsd_gtls.c:254 #1 0x000003fffd2358b4 in call_get_cert_callback (session=session@entry=0x3ffd8002ff0, issuers_dn=issuers_dn@entry=0x0, issuers_dn_length=issuers_dn_length@entry=0, pk_algos=pk_algos@entry=0x0, pk_algos_length=pk_algos_length@entry=0) at cert.c:483 #2 0x000003fffd236cda in _gnutls_server_select_cert (session=0x3ffd8002ff0, pk_algos=0x3fff57fd630, pk_algos_size=3) at cert.c:2015 #3 0x000003fffd1ab534 in remove_unwanted_ciphersuites (session=session@entry=0x3ffd8002ff0, cipher_suites=cipher_suites@entry=0x3fff57fd6b0 "\300+\300,\300\206\300\207\300\t\300#\300\n\300$\300r\300s\300\b\300\a\300/\300\060\300\212\300\213\300\023\300'\300\024\300(\300v\300w\300\022\300\021", cipher_suites_size=, pk_algos=pk_algos@entry=0x3fff57fd630, pk_algos_size=pk_algos_size@entry=3) at gnutls_handshake.c:3416 #4 0x000003fffd1ac59c in _gnutls_server_select_suite (session=0x3ffd8002ff0, data=0x3ffd8008d85 "\300+\300,\300\206\300\207\300\t\300#\300\n\300$\300r\300s\300\b\300\a\300/\300\060\300\212\300\213\300\023\300'\300\024\300(\300v\300w\300\022\300\021", datalen=) at gnutls_handshake.c:957 #5 0x000003fffd1af518 in read_client_hello (datalen=, data=0x3ffd8008d60 "\003\003V\251Y\320\367y\270\065\005,C[\343\346\277W\375\345\377\261\326\340\311`%\313\f\r\202=\204\211", session=0x3ffd8002ff0) at gnutls_handshake.c:665 #6 recv_hello (datalen=, data=0x3ffd8008d60 "\003\003V\251Y\320\367y\270\065\005,C[\343\346\277W\375\345\377\261\326\340\311`%\313\f\r\202=\204\211", session=0x3ffd8002ff0) at gnutls_handshake.c:2248 #7 _gnutls_recv_handshake (session=0x3ffd8002ff0, type=, optional=, buf=0x0) at gnutls_handshake.c:1458 #8 0x000003fffd1b1864 in handshake_server (session=0x3ffd8002ff0) at gnutls_handshake.c:3086 #9 gnutls_handshake (session=0x3ffd8002ff0) at gnutls_handshake.c:2558 #10 0x000003fffd385406 in AcceptConnReq (pNsd=0x2aa00101700, ppNew=0x3fff57fde18) at nsd_gtls.c:1478 #11 0x000003fffd581a94 in AcceptConnReq (pThis=0x2aa000f6790, ppNew=0x3fff57fded0) at netstrm.c:119 #12 0x000003fffd40358c in SessAccept (pThis=pThis@entry=0x2aa000be570, pLstnInfo=0x2aa000be6e0, ppSess=ppSess@entry=0x3fff57fdfc8, pStrm=) at tcpsrv.c:440 #13 0x000003fffd4047ca in processWorksetItem (pUsr=, idx=, pPoll=0x0, pThis=0x2aa000be570) at tcpsrv.c:612 #14 processWorkset (pThis=pThis@entry=0x2aa000be570, pPoll=pPoll@entry=0x0, numEntries=, numEntries@entry=1, workset=workset@entry=0x3fff57fe258) at tcpsrv.c:686 #15 0x000003fffd404dca in RunSelect (pThis=pThis@entry=0x2aa000be570, workset=workset@entry=0x3fff57fe258, sizeWorkset=128) at tcpsrv.c:821 #16 0x000003fffd404f94 in Run (pThis=0x2aa000be570) at tcpsrv.c:883 #17 0x000002aa0004cb36 in thrdStarter (arg=0x2aa00127360) at ../threads.c:212 #18 0x000003fffde079a2 in start_thread (arg=0x3fff57ff910) at pthread_create.c:335 #19 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 7 (Thread 0x3fff5fff910 (LWP 5484)): #0 0x000003fffda72f1c in ?? () at ../sysdeps/unix/syscall-template.S:81 from /lib/s390x-linux-gnu/libc.so.6 #1 0x000002aa0002dd9e in srSleep (iSeconds=, iuSeconds=) at srutils.c:494 #2 0x000003fffd785d7e in doPolling () at imfile.c:1218 #3 runInput (pThrd=) at imfile.c:1849 #4 0x000002aa0004cb36 in thrdStarter (arg=0x2aa00127080) at ../threads.c:212 #5 0x000003fffde079a2 in start_thread (arg=0x3fff5fff910) at pthread_create.c:335 #6 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 6 (Thread 0x3fff67ff910 (LWP 5483)): #0 0x000003fffde11208 in ?? () at ../sysdeps/unix/syscall-template.S:81 from /lib/s390x-linux-gnu/libpthread.so.0 #1 0x000003fffd802bec in read (__nbytes=8096, __buf=0x3fff67ded17, __fd=) at /usr/include/s390x-linux-gnu/bits/unistd.h:44 #2 readklog (pModConf=0x2aa000c2290) at bsd.c:253 #3 0x000003fffd802ff2 in klogLogKMsg (pModConf=) at bsd.c:311 #4 0x000003fffd8020bc in runInput (pThrd=0x2aa00126da0) at imklog.c:283 #5 0x000002aa0004cb36 in thrdStarter (arg=0x2aa00126da0) at ../threads.c:212 #6 0x000003fffde079a2 in start_thread (arg=0x3fff67ff910) at pthread_create.c:335 #7 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 5 (Thread 0x3fff6fff910 (LWP 5482)): #0 0x000003fffda72f1c in ?? () at ../sysdeps/unix/syscall-template.S:81 from /lib/s390x-linux-gnu/libc.so.6 #1 0x000003fffd905354 in runInput (pThrd=) at imuxsock.c:1445 #2 0x000002aa0004cb36 in thrdStarter (arg=0x2aa00126ac0) at ../threads.c:212 #3 0x000003fffde079a2 in start_thread (arg=0x3fff6fff910) at pthread_create.c:335 #4 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 4 (Thread 0x3fff77ff910 (LWP 5481)): #0 recv () at ../sysdeps/unix/sysv/linux/s390/s390-64/socket.S:122 #1 0x000003fffd1a9c0a in _gnutls_stream_read (ms=0x3fff77fe24c, pull_func=0x3fffd1c82c0 , size=5, bufel=, session=0x3ffe8008860) at gnutls_buffers.c:341 #2 _gnutls_read (ms=0x3fff77fe24c, pull_func=0x3fffd1c82c0 , size=5, bufel=, session=0x3ffe8008860) at gnutls_buffers.c:421 #3 _gnutls_io_read_buffered (session=0x3ffe8008860, total=5, recv_type=, ms=0x3fff77fe24c) at gnutls_buffers.c:564 #4 0x000003fffd1a458e in recv_headers (record_params=0x3ffe8009be0, ms=0x3fff77fe24c, record=0x3fff77fe298, htype=, type=, session=0x3ffe8008860) at gnutls_record.c:1048 #5 _gnutls_recv_in_buffers (session=0x3ffe8008860, type=, htype=, ms=0) at gnutls_record.c:1177 #6 0x000003fffd1ab0ae in _gnutls_handshake_io_recv_int (session=0x3ffe8008860, htype=, hsk=0x3fff77fe450, optional=) at gnutls_buffers.c:1389 #7 0x000003fffd1ae17a in _gnutls_recv_handshake (session=0x5a4f0a7290003, type=, optional=, buf=0x0) at gnutls_handshake.c:1419 #8 0x000003fffd1b0276 in handshake_client (session=) at gnutls_handshake.c:2715 #9 gnutls_handshake (session=0x3ffe8008860) at gnutls_handshake.c:2555 #10 0x000003fffd384fc2 in Connect (pNsd=0x3ffe8008720, family=, port=, host=0x2aa000cae90 "192.168.122.1") at nsd_gtls.c:1727 #11 0x000002aa0005ae40 in TCPSendInit (pvData=pvData@entry=0x3ffe8004660) at omfwd.c:705 #12 0x000002aa0005af48 in doTryResume (pWrkrData=0x3ffe8004660) at omfwd.c:762 #13 0x000002aa0004acb8 in actionPrepare (pWti=0x2aa0011fc10, pThis=0x2aa000cb170) at ../action.c:856 #14 processMsgMain (pAction=pAction@entry=0x2aa000cb170, pWti=pWti@entry=0x2aa0011fc10, pMsg=0x3ffe8002150, ttNow=ttNow@entry=0x3fff77feb30) at ../action.c:1299 #15 0x000002aa0004aef8 in processBatchMain (pVoid=0x2aa000cb170, pBatch=0x2aa0011fc40, pWti=0x2aa0011fc10) at ../action.c:1335 #16 0x000002aa0003f46e in ConsumerReg (pThis=0x2aa0011f7c0, pWti=0x2aa0011fc10) at queue.c:1898 #17 0x000002aa0003b7fa in wtiWorker (pThis=0x2aa0011fc10) at wti.c:334 #18 0x000002aa0003a610 in wtpWorker (arg=0x2aa0011fc10) at wtp.c:389 #19 0x000003fffde079a2 in start_thread (arg=0x3fff77ff910) at pthread_create.c:335 #20 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 3 (Thread 0x3fff7fff910 (LWP 5480)): #0 recv () at ../sysdeps/unix/sysv/linux/s390/s390-64/socket.S:122 #1 0x000003fffd1a9c0a in _gnutls_stream_read (ms=0x3fff7ffe24c, pull_func=0x3fffd1c82c0 , size=5, bufel=, session=0x3fff0008620) at gnutls_buffers.c:341 #2 _gnutls_read (ms=0x3fff7ffe24c, pull_func=0x3fffd1c82c0 , size=5, bufel=, session=0x3fff0008620) at gnutls_buffers.c:421 #3 _gnutls_io_read_buffered (session=0x3fff0008620, total=5, recv_type=, ms=0x3fff7ffe24c) at gnutls_buffers.c:564 #4 0x000003fffd1a458e in recv_headers (record_params=0x3fff00099a0, ms=0x3fff7ffe24c, record=0x3fff7ffe298, htype=, type=, session=0x3fff0008620) at gnutls_record.c:1048 #5 _gnutls_recv_in_buffers (session=0x3fff0008620, type=, htype=, ms=0) at gnutls_record.c:1177 #6 0x000003fffd1ab0ae in _gnutls_handshake_io_recv_int (session=0x3fff0008620, htype=, hsk=0x3fff7ffe450, optional=) at gnutls_buffers.c:1389 #7 0x000003fffd1ae17a in _gnutls_recv_handshake (session=0x5a4f0a7290003, type=, optional=, buf=0x0) at gnutls_handshake.c:1419 #8 0x000003fffd1b0276 in handshake_client (session=) at gnutls_handshake.c:2715 #9 gnutls_handshake (session=0x3fff0008620) at gnutls_handshake.c:2555 #10 0x000003fffd384fc2 in Connect (pNsd=0x3fff0002090, family=, port=, host=0x2aa000ca4d0 "172.17.42.1") at nsd_gtls.c:1727 #11 0x000002aa0005ae40 in TCPSendInit (pvData=pvData@entry=0x3fff0004390) at omfwd.c:705 #12 0x000002aa0005af48 in doTryResume (pWrkrData=0x3fff0004390) at omfwd.c:762 #13 0x000002aa0004acb8 in actionPrepare (pWti=0x2aa0011a1a0, pThis=0x2aa000ca660) at ../action.c:856 #14 processMsgMain (pAction=pAction@entry=0x2aa000ca660, pWti=pWti@entry=0x2aa0011a1a0, pMsg=0x3fff0002150, ttNow=ttNow@entry=0x3fff7ffeb30) at ../action.c:1299 #15 0x000002aa0004aef8 in processBatchMain (pVoid=0x2aa000ca660, pBatch=0x2aa0011a1d0, pWti=0x2aa0011a1a0) at ../action.c:1335 #16 0x000002aa0003f46e in ConsumerReg (pThis=0x2aa00119d50, pWti=0x2aa0011a1a0) at queue.c:1898 #17 0x000002aa0003b7fa in wtiWorker (pThis=0x2aa0011a1a0) at wti.c:334 #18 0x000002aa0003a610 in wtpWorker (arg=0x2aa0011a1a0) at wtp.c:389 #19 0x000003fffde079a2 in start_thread (arg=0x3fff7fff910) at pthread_create.c:335 #20 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 2 (Thread 0x3fffcdff910 (LWP 5479)): #0 recv () at ../sysdeps/unix/sysv/linux/s390/s390-64/socket.S:122 #1 0x000003fffd1a9c0a in _gnutls_stream_read (ms=0x3fffcdfe24c, pull_func=0x3fffd1c82c0 , size=5, bufel=, session=0x3fff8008760) at gnutls_buffers.c:341 #2 _gnutls_read (ms=0x3fffcdfe24c, pull_func=0x3fffd1c82c0 , size=5, bufel=, session=0x3fff8008760) at gnutls_buffers.c:421 #3 _gnutls_io_read_buffered (session=0x3fff8008760, total=5, recv_type=, ms=0x3fffcdfe24c) at gnutls_buffers.c:564 #4 0x000003fffd1a458e in recv_headers (record_params=0x3fff8009ae0, ms=0x3fffcdfe24c, record=0x3fffcdfe298, htype=, type=, session=0x3fff8008760) at gnutls_record.c:1048 #5 _gnutls_recv_in_buffers (session=0x3fff8008760, type=, htype=, ms=0) at gnutls_record.c:1177 #6 0x000003fffd1ab0ae in _gnutls_handshake_io_recv_int (session=0x3fff8008760, htype=, hsk=0x3fffcdfe450, optional=) at gnutls_buffers.c:1389 #7 0x000003fffd1ae17a in _gnutls_recv_handshake (session=0x5a4f0a7290003, type=, optional=, buf=0x0) at gnutls_handshake.c:1419 #8 0x000003fffd1b0276 in handshake_client (session=) at gnutls_handshake.c:2715 #9 gnutls_handshake (session=0x3fff8008760) at gnutls_handshake.c:2555 #10 0x000003fffd384fc2 in Connect (pNsd=0x3fff8002090, family=, port=, host=0x2aa000c8950 "10.245.232.4") at nsd_gtls.c:1727 #11 0x000002aa0005ae40 in TCPSendInit (pvData=pvData@entry=0x3fff8004500) at omfwd.c:705 #12 0x000002aa0005af48 in doTryResume (pWrkrData=0x3fff8004500) at omfwd.c:762 #13 0x000002aa0004acb8 in actionPrepare (pWti=0x2aa001007a0, pThis=0x2aa000c9ae0) at ../action.c:856 #14 processMsgMain (pAction=pAction@entry=0x2aa000c9ae0, pWti=pWti@entry=0x2aa001007a0, pMsg=0x3fff8002150, ttNow=ttNow@entry=0x3fffcdfeb30) at ../action.c:1299 #15 0x000002aa0004aef8 in processBatchMain (pVoid=0x2aa000c9ae0, pBatch=0x2aa001007d0, pWti=0x2aa001007a0) at ../action.c:1335 #16 0x000002aa0003f46e in ConsumerReg (pThis=0x2aa00100310, pWti=0x2aa001007a0) at queue.c:1898 #17 0x000002aa0003b7fa in wtiWorker (pThis=0x2aa001007a0) at wti.c:334 #18 0x000002aa0003a610 in wtpWorker (arg=0x2aa001007a0) at wtp.c:389 #19 0x000003fffde079a2 in start_thread (arg=0x3fffcdff910) at pthread_create.c:335 #20 0x000003fffda7a692 in thread_start () at ../sysdeps/unix/sysv/linux/s390/s390-64/clone.S:74 Thread 1 (Thread 0x3fffdff3760 (LWP 5476)): #0 0x000003fffda72f1c in ?? () at ../sysdeps/unix/syscall-template.S:81 from /lib/s390x-linux-gnu/libc.so.6 #1 0x000002aa00016cda in mainloop () at rsyslogd.c:1494 #2 main (argc=, argv=) at rsyslogd.c:1628 (gdb) quit A debugging session is active. Inferior 1 [process 5476] will be killed. Quit anyway? (y or n) y