﻿[11-Oct-2013 10:59:55.471] [DEBUG] [CLSN-0] Received message CMD_SET_DCI_STATUS
[11-Oct-2013 10:59:55.471] [DEBUG] [CLSN-0] Sending message CMD_REQUEST_COMPLETED
[11-Oct-2013 10:59:55.471] [DEBUG] Event::expandText(event=0x8126de8 sourceObject=629 template='Status of DCI %1 (%5: %2) changed to ACTIVE' alarmMsg='(null)')
[11-Oct-2013 10:59:55.471] [DEBUG] CorrelateEvent: event SYS_DCI_ACTIVE id 109874 source VPNSERVER-NIK [629]
[11-Oct-2013 10:59:55.471] [DEBUG] CorrelateEvent: finished, rootId=0
[11-Oct-2013 10:59:55.471] [DEBUG] EVENT 55 (ID:109874 F:0x0001 S:0 TAG:"") FROM VPNSERVER-NIK: Status of DCI 1051 (SNMP: .1.3.6.1.4.1.9.9.171.1.2.3.1.7) changed to ACTIVE
[11-Oct-2013 10:59:55.471] [DEBUG] EPP: processing event 109874
[11-Oct-2013 10:59:55.471] [DEBUG] Event 109874 match EPP rule 14
[11-Oct-2013 10:59:55.471] [DEBUG] Event::expandText(event=0x8126de8 sourceObject=629 template='DCI_STATUS_%i_%1' alarmMsg='(null)')
[11-Oct-2013 10:59:55.471] [DEBUG] Event 109874 with code 55 passed event processing policy
[11-Oct-2013 10:59:55.472] [DEBUG] [CLSN-0] Sending message CMD_EVENTLOG_RECORDS
[11-Oct-2013 10:59:55.472] [DEBUG] Successful sync query: "SELECT var_value FROM metadata WHERE var_name='Syntax'" [0 ms]
[11-Oct-2013 10:59:55.472] [DEBUG] {0x8167830} Successful prepare: "INSERT INTO event_log (event_id,event_code,event_timestamp,event_source,event_severity,event_message,root_event_id,user_tag) VALUES (?,?,?,?,?,?,?,?)" [0 ms]
[11-Oct-2013 10:59:55.472] [DEBUG] {0x8167830} bind at pos 1: "109874"
[11-Oct-2013 10:59:55.472] [DEBUG] {0x8167830} bind at pos 2: "55"
[11-Oct-2013 10:59:55.472] [DEBUG] {0x8167830} bind at pos 3: "1381474795"
[11-Oct-2013 10:59:55.472] [DEBUG] {0x8167830} bind at pos 4: "629"
[11-Oct-2013 10:59:55.472] [DEBUG] {0x8167830} bind at pos 5: "0"
[11-Oct-2013 10:59:55.472] [DEBUG] {0x8167830} bind at pos 6: "Status of DCI 1051 (SNMP: .1.3.6.1.4.1.9.9.171.1.2.3.1.7) changed to ACTIVE"
[11-Oct-2013 10:59:55.472] [DEBUG] {0x8167830} bind at pos 7: "0"
[11-Oct-2013 10:59:55.472] [DEBUG] {0x8167830} bind at pos 8: "8д╞Їf DCI 1051 (SNMP: .1.3.6.1.4.1.9.9.171.1.2.3.1.7) chang"
[11-Oct-2013 10:59:55.472] [DEBUG] Successful prepared sync query: "INSERT INTO event_log (event_id,event_code,event_timestamp,event_source,event_severity,event_message,root_event_id,user_tag) VALUES (?,?,?,?,?,?,?,?)" [0 ms]
[11-Oct-2013 10:59:55.472] [DEBUG] EventLogger: DBExecute: id=109874,code=55
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: wakeup
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object syslog [100]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object FILES NIK [111]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object VPNSERVER-KALUGA [122]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object FIREWALL-NIK ASA 5510 [155]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object FIREWALL-KALUGA PIX 5606 [166]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object FORS KALUGA [171]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object APC smart 8000XL NIK [181]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object CSP VPN GATE 3000 NIK [195]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object 3com1 [198]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object 3com2 [223]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object 3com3 [256]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object HP ProCurve [313]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object Catalyst1 [342]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object Catalyst2 [397]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object Catalyst3 [450]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object proxy Squid NIK [580]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object Exchange 2010 MAIL4 [583]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object FORS KALUGA REZ [609]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object APPSERRVER [620]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object VPNSERVER-NIK [624]
[11-Oct-2013 10:59:56.256] [DEBUG] ItemPoller: calling DataCollectionTarget::queueItemsForPolling for object VPNSERVER-NIK [629]
[11-Oct-2013 10:59:56.256] [DEBUG] DataCollector(): processing DC object 1051 ".1.3.6.1.4.1.9.9.171.1.2.3.1.7" owner=629 proxy=0
[11-Oct-2013 10:59:56.256] [DEBUG] DataCollectionTarget(VPNSERVER-NIK)->QueueItemsForPolling(): item 1051 ".1.3.6.1.4.1.9.9.171.1.2.3.1.7" added to queue
[11-Oct-2013 10:59:56.355] [DEBUG] BEGIN TRANSACTION successful (level 1)
[11-Oct-2013 10:59:56.355] [DEBUG] {0xb7221190} Successful prepare: "INSERT INTO tdata_629 (item_id,tdata_timestamp,record_id) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.355] [DEBUG] {0xb7221190} bind at pos 1: "1051"
[11-Oct-2013 10:59:56.355] [DEBUG] {0xb7221190} bind at pos 2: "1381474796"
[11-Oct-2013 10:59:56.355] [DEBUG] {0xb7221190} bind at pos 3: "1483347267284287488"
[11-Oct-2013 10:59:56.355] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_629 (item_id,tdata_timestamp,record_id) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.355] [DEBUG] {0xb7221190} Successful prepare: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.355] [DEBUG] {0xb7221190} bind at pos 1: "1483347267284287488"
[11-Oct-2013 10:59:56.355] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287488"
[11-Oct-2013 10:59:56.355] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.356] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.356] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287489"
[11-Oct-2013 10:59:56.356] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.356] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.356] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287490"
[11-Oct-2013 10:59:56.356] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.357] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [1 ms]
[11-Oct-2013 10:59:56.357] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287491"
[11-Oct-2013 10:59:56.357] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.357] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.357] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287492"
[11-Oct-2013 10:59:56.357] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.357] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.357] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287493"
[11-Oct-2013 10:59:56.357] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.358] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [1 ms]
[11-Oct-2013 10:59:56.358] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287494"
[11-Oct-2013 10:59:56.358] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.358] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.358] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287495"
[11-Oct-2013 10:59:56.358] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.358] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.358] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287496"
[11-Oct-2013 10:59:56.359] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.359] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.359] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287497"
[11-Oct-2013 10:59:56.359] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.359] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.359] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287498"
[11-Oct-2013 10:59:56.359] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.360] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [1 ms]
[11-Oct-2013 10:59:56.360] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287499"
[11-Oct-2013 10:59:56.360] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.360] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.360] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287500"
[11-Oct-2013 10:59:56.360] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.360] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.360] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287501"
[11-Oct-2013 10:59:56.360] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.361] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [1 ms]
[11-Oct-2013 10:59:56.361] [DEBUG] {0xb7221190} bind at pos 2: "1483347267284287502"
[11-Oct-2013 10:59:56.361] [DEBUG] {0xb7221190} bind at pos 3: ""
[11-Oct-2013 10:59:56.361] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_records_629 (record_id,row_id,instance) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.361] [DEBUG] {0xb72134f8} Successful prepare: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.361] [DEBUG] {0xb721ddd0} Successful prepare: "SELECT column_id FROM dct_column_names WHERE column_name=?" [0 ms]
[11-Oct-2013 10:59:56.361] [DEBUG] {0xb721ddd0} bind at pos 1: "nikVpn"
[11-Oct-2013 10:59:56.362] [DEBUG] Successful prepared sync query: "SELECT column_id FROM dct_column_names WHERE column_name=?" [1 ms]
[11-Oct-2013 10:59:56.362] [DEBUG] DCTable::columnIdFromName(): column name nikVpn added to cache, ID=5
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287488"
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 3: "pix147.tfbank.ru"
[11-Oct-2013 10:59:56.362] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287489"
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 3: "pixf141.tfbank.ru"
[11-Oct-2013 10:59:56.362] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287490"
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 3: "pix9.tfbank.ru"
[11-Oct-2013 10:59:56.362] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287491"
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.362] [DEBUG] {0xb72134f8} bind at pos 3: "pix151.tfbank.ru"
[11-Oct-2013 10:59:56.362] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287492"
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 3: "pmir.tfbank.ru"
[11-Oct-2013 10:59:56.363] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287493"
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 3: "sevastopol.tfbank.ru"
[11-Oct-2013 10:59:56.363] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287494"
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 3: "pix143.tfbank.ru"
[11-Oct-2013 10:59:56.363] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287495"
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 3: "miusskaya.tfbank.ru"
[11-Oct-2013 10:59:56.363] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287496"
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.363] [DEBUG] {0xb72134f8} bind at pos 3: "213.033.215.038"
[11-Oct-2013 10:59:56.363] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287497"
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 3: "062.141.087.078"
[11-Oct-2013 10:59:56.364] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287498"
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 3: "212.118.050.200"
[11-Oct-2013 10:59:56.364] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287499"
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 3: "109.095.083.174"
[11-Oct-2013 10:59:56.364] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287500"
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 3: "178.214.032.162"
[11-Oct-2013 10:59:56.364] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287501"
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.364] [DEBUG] {0xb72134f8} bind at pos 3: "178.208.132.186"
[11-Oct-2013 10:59:56.364] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287502"
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 2: "5"
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 3: "pix139.tfbank.ru"
[11-Oct-2013 10:59:56.365] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb7291ab0} Successful prepare: "SELECT column_id FROM dct_column_names WHERE column_name=?" [0 ms]
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb7291ab0} bind at pos 1: "nikVpnTunAT"
[11-Oct-2013 10:59:56.365] [DEBUG] Successful prepared sync query: "SELECT column_id FROM dct_column_names WHERE column_name=?" [0 ms]
[11-Oct-2013 10:59:56.365] [DEBUG] DCTable::columnIdFromName(): column name nikVpnTunAT added to cache, ID=9
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287488"
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 3: "6585102"
[11-Oct-2013 10:59:56.365] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287489"
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 3: "6585134"
[11-Oct-2013 10:59:56.365] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287490"
[11-Oct-2013 10:59:56.365] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 3: "6585066"
[11-Oct-2013 10:59:56.366] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287491"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 3: "6585012"
[11-Oct-2013 10:59:56.366] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287492"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 3: "6584924"
[11-Oct-2013 10:59:56.366] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287493"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 3: "6584605"
[11-Oct-2013 10:59:56.366] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287494"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 3: "6584010"
[11-Oct-2013 10:59:56.366] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287495"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.366] [DEBUG] {0xb72134f8} bind at pos 3: "6582456"
[11-Oct-2013 10:59:56.367] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287496"
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 3: "6568315"
[11-Oct-2013 10:59:56.367] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287497"
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 3: "6563828"
[11-Oct-2013 10:59:56.367] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287498"
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 3: "6262229"
[11-Oct-2013 10:59:56.367] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287499"
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 3: "6224674"
[11-Oct-2013 10:59:56.367] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287500"
[11-Oct-2013 10:59:56.367] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72134f8} bind at pos 3: "5900224"
[11-Oct-2013 10:59:56.368] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287501"
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72134f8} bind at pos 3: "5891933"
[11-Oct-2013 10:59:56.368] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287502"
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72134f8} bind at pos 2: "9"
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72134f8} bind at pos 3: "47265"
[11-Oct-2013 10:59:56.368] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [0 ms]
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72506b0} Successful prepare: "SELECT column_id FROM dct_column_names WHERE column_name=?" [0 ms]
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72506b0} bind at pos 1: "nikVpnSecTunAT"
[11-Oct-2013 10:59:56.368] [DEBUG] Successful prepared sync query: "SELECT column_id FROM dct_column_names WHERE column_name=?" [0 ms]
[11-Oct-2013 10:59:56.368] [DEBUG] DCTable::columnIdFromName(): column name nikVpnSecTunAT added to cache, ID=10
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287488"
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72134f8} bind at pos 2: "10"
[11-Oct-2013 10:59:56.368] [DEBUG] {0xb72134f8} bind at pos 3: "559346"
[11-Oct-2013 10:59:56.369] [DEBUG] Successful prepared sync query: "INSERT INTO tdata_rows_629 (row_id,column_id,value) VALUES (?,?,?)" [1 ms]
[11-Oct-2013 10:59:56.369] [DEBUG] {0xb72134f8} bind at pos 1: "1483347267284287489"
[11-Oct-2013 10:59:56.369] [DEBUG] {0xb72134f8} bind at pos 2: "10"

Program received signal SIGSEGV, Segmentation fault.
[Switching to Thread 0xb58ffb70 (LWP 26769)]
0xb7a15d03 in strlen () from /lib/libc.so.6
(gdb)
(gdb) bt
#0  0xb7a15d03 in strlen () from /lib/libc.so.6
#1  0xb7f1dec1 in DCTable::processNewValue (this=0x8159628, nTimeStamp=1381474796, value=0xb721f7b8) at dctable.cpp:389
#2  0xb7f21120 in DataCollectionTarget::processNewDCValue (this=0x812a6a8, dco=0x8159628, currTime=1381474796, value=0xb721f7b8) at dctarget.cpp:366
#3  0xb7f0d1af in DataCollector (pArg=0x0) at datacoll.cpp:254
#4  0xb7c38830 in start_thread () from /lib/libpthread.so.0
#5  0xb7a7c15e in clone () from /lib/libc.so.6
