Datasourcer DBserver error

Vishwasam · July 23, 2015, 11:40am

I am working on lab setup for CCpulse and CC Analyzer. unable to start the datasourcer with the DB connections i created

Please find the log below and let me know where I need to correct

WARNING:
This log file is provided solely for a troubleshooting purposes.
It must not be used for any kind of reporting, because provided data may be incomplete.

Data Sourcer (32-bit) Version: 8.0.100.12 Compiled: Mar 12 2014 09:48:35
Copyright (C) Genesys Telecommunications Laboratories Inc., 1998-2014. All rights reserved.
CommonLib 8.1.200.14 C2
DbLib 8.1.200.00
ConfServLib 8.1.200.07
LCALib 8.1.200.06
GMessageLib 8.1.200.00
LogLib 8.1.200.04
GThreadLib 8.1.200.00
GServiceLib 8.1.200.01 MT
MngmLib 8.1.200.00
NSOLib 8.1.001.03 __try/except
StatLib 8.1.000.13
SupportLib 8.1.200.01
pthreads-win32 2.8.0.0

Application name: Data_Sourcer
Application type: DataSourcer (38)
Command line: data_sourcer.exe -service CCADataSourcer -app Data_Sourcer -host WIN-B3NODD1C3U9 -port 3030 -sstart
Host name: WIN-B3NODD1C3U9
DST: TZ = 0, timeb = 0
Time zone: -19800, India Standard Time, India Daylight Time
UTC time: 2015-07-23T11:33:59.591
Local time: 2015-07-23T17:03:59.591
Start time (UTC): 2015-07-23T11:33:59
Running time: 0:00:00:00
Host info: Windows 6.1.7600, 2, , 0.0, 0110, 3
File: (1) D:\logs\Data_Sourcer\Data_Sourcer.20150723_170359_591.log

17:03:59.591 Trc 04112 The Log Output of type ‘D:\logs\Data_Sourcer\Data_Sourcer’ has been created and opened
17:03:59.590 Trc 04110 Option ‘verbose’ has been set to the value ‘all’
17:03:59.590 Trc 04110 Option ‘buffering’ has been set to the value ‘no’
17:03:59.590 Trc 04110 Option ‘expire’ has been set to the value ‘no’
17:03:59.590 Trc 04110 Option ‘segment’ has been set to the value ‘no’
17:03:59.590 Trc 04110 Option ‘spool’ has been set to the value ‘’
17:03:59.590 Trc 04110 Option ‘keep-startup-file’ has been set to the value ‘no’
17:03:59.590 Trc 04110 Option ‘MessageFile’ has been set to the value ‘data_sourcer.lms’
17:03:59.590 Trc 04110 Option ‘time-format’ has been set to the value ‘time’
17:03:59.590 Trc 04110 Option ‘time-convert’ has been set to the value ‘local’
17:03:59.590 Trc 04110 Option ‘message-format’ has been set to the value ‘short’
17:03:59.590 Trc 04110 Option ‘memory-storage-size’ has been set to the value ‘2 Mb’
17:03:59.590 Trc 04110 Option ‘compatible-output-priority’ has been set to the value ‘no’
17:03:59.590 Trc 04110 Option ‘print-attributes’ has been set to the value ‘no’
17:03:59.590 Trc 04110 Option ‘check-point’ has been set to the value ‘1’
17:03:59.590 Trc 04110 Option ‘memory’ has been set to the value ‘’
17:03:59.590 Std 04106 Log Messages file ‘data_sourcer.lms’ successfully loaded
17:03:59.591 Trc 04112 The Log Output of type ‘D:\logs\Data_Sourcer\Data_Sourcer’ has been created and opened
17:03:59.591 Trc 04100 Logging service started
2015-07-23 17:03:59.591 (6304) LCALayer: Register LCA client
Open LCALayer on port=4999
LCA Library version 8.1.200.06
._17:03:59.5910_resolving of host name ‘WIN-B3NODD1C3U9’
._17:03:59.5930_name ‘WIN-B3NODD1C3U9’ resolved

LCALayer: REventRegistered on LCA…

LCALayer: The local host is under conrol of Management Layer. SCS ‘SolutionControlServer’ has connected to the LCA from the host ‘’ on the socket 508.
2015-07-23 17:03:59.593

Data Sourcer (32-bit) Version: 8.0.100.12 Compiled: Mar 12 2014 09:48:35
Copyright (C) Genesys Telecommunications Laboratories Inc., 1998-2014. All rights reserved.
CommonLib 8.1.200.14 C2
DbLib 8.1.200.00
ConfServLib 8.1.200.07
LCALib 8.1.200.06
GMessageLib 8.1.200.00
LogLib 8.1.200.04
GThreadLib 8.1.200.00
GServiceLib 8.1.200.01 MT
MngmLib 8.1.200.00
NSOLib 8.1.001.03 __try/except
StatLib 8.1.000.13
SupportLib 8.1.200.01
pthreads-win32 2.8.0.0

2015-07-23 17:03:59.593 IPv6 is not enabled.
2015-07-23 17:03:59.593 (6304) Reading configuration options for ‘Data_Sourcer’…
2015-07-23 17:03:59.593 (6304) Options Section ‘collector’
17:03:59.593 Trc 06084 Configuration option set: ‘collector’:‘activate-new-layouts’ = ‘true’
17:03:59.593 Trc 06084 Configuration option set: ‘collector’:‘chunk-composition-mode’ = ‘Legacy’
17:03:59.593 Trc 06084 Configuration option set: ‘collector’:‘conf-check-interval’ = ‘3600 seconds’
17:03:59.593 Std 06083 Configuration option has invalid value: ‘collector’:‘data-table-size’ = ‘’.
17:03:59.593 Trc 06085 Configuration option set to default value: ‘collector’:‘data-table-size’ = ‘1000000’
17:03:59.593 Trc 06084 Configuration option set: ‘collector’:‘data-table-size’ = ‘1000000’
17:03:59.593 Trc 06084 Configuration option set: ‘collector’:‘emergency-save-directory’ = ‘’
17:03:59.593 Std 06083 Configuration option has invalid value: ‘collector’:‘management-port’ = ‘’.
17:03:59.593 Trc 06085 Configuration option set to default value: ‘collector’:‘management-port’ = ‘0’
17:03:59.593 Trc 06084 Configuration option set: ‘collector’:‘management-port’ = ‘0’
2015-07-23 17:03:59.594 (6304) Options Section ‘Log’
17:03:59.594 Trc 06084 Configuration option set: ‘Log’:‘all’ = ‘D:\logs\Data_Sourcer\Data_Sourcer’
17:03:59.594 Trc 06084 Configuration option set: ‘Log’:‘buffering’ = ‘false’
17:03:59.594 Trc 06084 Configuration option set: ‘Log’:‘verbose’ = ‘all’
2015-07-23 17:03:59.594 (6304) Loading connected tenants…
2015-07-23 17:03:59.594 (6304) Found connected tenant ‘Environment’ (1)
2015-07-23 17:03:59.594 (6304) Loaded 1 tenants.
2015-07-23 17:03:59.594 (6304) Loading switches…
2015-07-23 17:03:59.595 (6304) Loaded 0 switches.
2015-07-23 17:03:59.595 (6304) Loading connected servers…
2015-07-23 17:03:59.599 (6304) Server StatServer DBID(113) protocol timeout local/remote 0/0 mode 1
2015-07-23 17:03:59.599 (6304) Server MessageServer DBID(107) protocol timeout local/remote 0/0 mode 1
2015-07-23 17:03:59.600 (6304) Server Datasource_DBServer DBID(155) protocol timeout local/remote 0/0 mode 1
2015-07-23 17:03:59.601 (6304) Server Datasource_DAP DBID(156) protocol timeout local/remote 0/0 mode 1
2015-07-23 17:03:59.601 (6304) Server confserv DBID(99) protocol timeout local/remote 0/0 mode 1
2015-07-23 17:03:59.601 (6304) Setting ODS update mode…
2015-07-23 17:03:59.601 (6304) Activating StatCluster…
2015-07-23 17:03:59.601 (6304) StatCluster activated.
2015-07-23 17:03:59.601 (6880) Entered thread ‘StatCluster’ id 0
2015-07-23 17:03:59.601 (6880) Started thread ‘StatCluster’ id 6880
2015-07-23 17:03:59.603 (6304) Loaded 5 servers.
2015-07-23 17:03:59.603 (6304) DBAccessPoint ‘Datasource_DAP’: DB login ‘sa’ mapped to the DB schema ‘dbo’
2015-07-23 17:03:59.603 (6304) Waiting for 3 seconds before checking StatCluster configuration…
2015-07-23 17:04:02.603 (6304) Checking StatCluster configuration…
2015-07-23 17:04:02.603 (6304) Parsing StatCluster configuration data…
2015-07-23 17:04:02.603 (6304) StatCluster connection StatServer DBID(113) protocol timeout local/remote 0/0 mode 1
2015-07-23 17:04:02.604 (6304) StatServer-:7090[-1] StatServer configuration loaded.
2015-07-23 17:04:02.604 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] Processing StatServer configuration…
2015-07-23 17:04:02.604 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] Connected Tenants:
2015-07-23 17:04:02.604 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] Added Tenant ‘Environment’ (DBID 1)
2015-07-23 17:04:02.606 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] Added Tenant ‘SensipleLab’ (DBID 101)
2015-07-23 17:04:02.606 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] Processing StatServer options…
2015-07-23 17:04:02.608 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] Skipping well-known configuration section ‘common’.
2015-07-23 17:04:02.609 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] Skipping well-known configuration section ‘log’.
2015-07-23 17:04:02.609 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] Skipping well-known configuration section ‘log-filter’.
2015-07-23 17:04:02.609 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] Skipping well-known configuration section ‘statserver’.
2015-07-23 17:04:02.616 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] StatServer configuration processed.
2015-07-23 17:04:02.617 (6304) StatCluster configuration processed.
2015-07-23 17:04:02.617 (6304) StatCluster: Opening connections…
2015-07-23 17:04:02.617 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1]: Activating StatServer (UniqueID=0)…
2015-07-23 17:04:02.618 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1]: StatServer (UniqueID=0) activated.
2015-07-23 17:04:02.618 (6304) StatServer-WIN-B3NODD1C3U9:7090[-1] Establishing connection…
._17:04:02.6180_resolving of host name ‘WIN-B3NODD1C3U9’
._17:04:02.6180_name ‘WIN-B3NODD1C3U9’ resolved
2015-07-23 17:04:02.619 (6304) StatServer-WIN-B3NODD1C3U9:7090[2132] Created socket 2132
2015-07-23 17:04:02.621 (6304) Collector: Connected to CfgServer, waiting when it is ready…
2015-07-23 17:04:02.621 (6304) Updating CfgServer information…
2015-07-23 17:04:02.621 (6304) Collector: CfgServer ready.
2015-07-23 17:04:02.621 (6304) Opening database connection…
2015-07-23 17:04:02.621 (6304) Preparing to connect to DBServer (-1)[-1] host WIN-B3NODD1C3U9:7006
2015-07-23 17:04:02.621 (6304) Connecting to DBServer (-1)[-1] host WIN-B3NODD1C3U9:7006
._17:04:02.6210_resolving of host name ‘WIN-B3NODD1C3U9’
._17:04:02.6210_name ‘WIN-B3NODD1C3U9’ resolved
2015-07-23 17:04:02.623 (3216) Entered thread ‘StatMsgThread-0’ id 0
2015-07-23 17:04:02.623 (3216) Started thread ‘StatMsgThread-0’ id 3216
2015-07-23 17:04:02.623 (3216) StatMsgThread(StatServer-WIN-B3NODD1C3U9:7090[2132]): thread started.
17:04:02.623 Std 04503 Connected to StatServer-WIN-B3NODD1C3U9:7090[2132] ‘StatServer’ at host ‘WIN-B3NODD1C3U9’, port 7090
2015-07-23 17:04:02.624 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Current timeout for receiving server profiles is 600 seconds
2015-07-23 17:04:02.624 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Requesting profile type [0]…
2015-07-23 17:04:02.624 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Requested profile type [0], RequestID=1
2015-07-23 17:04:02.626 (6328) Entered thread ‘StatServer’ id 0
2015-07-23 17:04:02.626 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Requesting profile type [1]…
2015-07-23 17:04:02.626 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Requested profile type [1], RequestID=2
2015-07-23 17:04:02.626 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Requesting profile type [3]…
2015-07-23 17:04:02.626 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Requested profile type [3], RequestID=3
2015-07-23 17:04:02.626 (6328) Started thread ‘StatServer’ id 6328
2015-07-23 17:04:02.627 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Requesting profile type [2]…
2015-07-23 17:04:02.627 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Requested profile type [2], RequestID=4
2015-07-23 17:04:02.627 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Processing server profile…
2015-07-23 17:04:02.627 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Server profile type is [0] StatTypes
2015-07-23 17:04:02.629 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Server profile processed.
2015-07-23 17:04:02.629 (6328) StatServer-WIN-B3NODD1C3U9:7090[2132] Waiting for new requests.
2015-07-23 17:04:02.629 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Processing server profile…
2015-07-23 17:04:02.629 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Server profile type is [1] TimeProfiles
2015-07-23 17:04:02.632 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Server profile processed.
2015-07-23 17:04:02.632 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Processing server profile…
2015-07-23 17:04:02.633 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Server profile type is [3] TimeRanges
2015-07-23 17:04:02.633 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Server profile processed.
2015-07-23 17:04:02.633 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Processing server profile…
2015-07-23 17:04:02.633 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Server profile type is [2] Filters
17:04:02.633 Std 20033 All server profiles received from the StatServer-WIN-B3NODD1C3U9:7090[2132] ‘StatServer’ at host ‘WIN-B3NODD1C3U9’, port 7090
2015-07-23 17:04:02.633 (3216) Collector: New Message (16,1) ‘MsgTypeStatClusterChanged’ [0]
2015-07-23 17:04:02.633 (3216) StatServer-WIN-B3NODD1C3U9:7090[2132] Server profile processed.
2015-07-23 17:04:02.633 (6328) StatServer-WIN-B3NODD1C3U9:7090[2132] Waiting for new requests.
2015-07-23 17:04:02.657 (5644) [Collector_DBServer] Switched from DBServer Mode [0] to DBServer Mode [0]

Thanks

Kubig · July 23, 2015, 11:56am

Why do you configure connection to the DBServer? You just need connection to the DAP. Meanwhile, try to post log of DBServer covering the issue - there appears more details informations.

ryusuf · July 23, 2015, 3:05pm

Hi Kubig,

Infact i am facing an issue with DataSourcer too.

Here is what the error shows in the DataSourcer logs.

2015-07-23 18:02:50.540 (4664) DMAServer: Setting up socket…
2015-07-23 18:02:50.541 (4664) DMAServer: Listening on the port 13520…
2015-07-23 18:02:50.541 (5848) DBAccessPoint ‘ODS_DAP’: DB login ‘sa’ mapped to the DB schema ‘dbo’
2015-07-23 18:02:50.541 (5848) DBWriter: Setting ESF ‘E:\Genesys\Reporting\Historical’…
2015-07-23 18:02:50.541 (5848) DBWriter: Folder ‘E:\Genesys\Reporting\Historical’ exists.
2015-07-23 18:02:50.541 (5848) DBWriter: Setting BCF ‘E:\Genesys\Reporting\Historical\bad_chunks’…
2015-07-23 18:02:50.542 (5848) DBWriter: Folder ‘E:\Genesys\Reporting\Historical\bad_chunks’ exists.
2015-07-23 18:02:50.542 (5848) DBWriter: Scanning ESF…
2015-07-23 18:02:50.542 (5376) StatServer-genesys:3102[1624] Checking statistical parameters of type ‘StatType’…
2015-07-23 18:02:50.543 (5848) DBWriter: ESF scan complete. Found 0 files. Accepted 0 chunk files.
2015-07-23 18:02:50.543 (5848) Preparing to connect to DBServer (-1)[-1] host genesys:4040
2015-07-23 18:02:50.543 (5848) Connecting to DBServer (-1)[-1] host genesys:4040
2015-07-23 18:02:50.547 (5376) Database error: DataAccessException: ErrorCode=5 ErrorMessage: serverError. [Microsoft][ODBC SQL Server Driver][SQL Server]Cannot find either column “genesys” or the user-defined function or aggregate “genesys.RAWTOHEX”, or the name is ambiguous.
2015-07-23 18:02:50.550 (5376) Setting up configuration recheck timer (3600 s)…
2015-07-23 18:02:50.551 (5376) Waiting for the 5 seconds before reconnect…
18:02:50.594 Std 04503 Connected to DAP ODS_DAP [1752] at DBServer ‘DBServer’ at host ‘genesys’, port 4040
2015-07-23 18:02:50.594 (5848) DBWriter: Connected to ODS.
2015-07-23 18:02:50.594 (5848) DBWriter: Queue size 0
2015-07-23 18:02:50.594 (5848) DBWriter: Chunk object size is 88 bytes.
2015-07-23 18:02:50.595 (5848) DBWriter: Chunk queue element min. size is 108 bytes.
2015-07-23 18:02:50.595 (5848) DBWriter: Entering data processing loop…

Initially i thought it wouldn’t be much concern as in the GA, i can find the DataSourcer started. But when i try to connect DMA to the Data Sourcer i get the error “Cannot connect to DBServer” And the DBServer logs are as shown below..

18:11:06.742 Dbg 10741 ‘App (DataSourcer,genesys,13520)’ has put request id=‘526’ type=‘MSG_EXECSQL’ into queue
18:11:06.742 Dbg 10739 SELECT STAT_TYPE_ID, STAT_TYPE_NAME, ‘StatType’ AS PARAMETER_KEY FROM OL_STAT_TYPE
18:11:06.742 Dbg 10737 Forwarding request ‘526’ from ‘App (DataSourcer,genesys,13520)’ to ‘MS SQL: 974.1’
18:11:06.743 Dbg 10743 ‘MS SQL: 974.1’ is spare
18:11:06.745 Dbg 10749 Forwarding response ‘526.1’ from ‘MS SQL: 974.1’ to ‘App (DataSourcer,genesys,13520)’
18:11:06.745 Dbg 10749 Forwarding response ‘526.2’ from ‘MS SQL: 974.1’ to ‘App (DataSourcer,genesys,13520)’
18:11:06.745 Dbg 10739 ODBC: id=‘974.1’ req=‘526’ SQL: SELECT STAT_TYPE_ID, STAT_TYPE_NAME, ‘StatType’ AS PARAMETER_KEY FROM OL_STAT_TYPE
+0001 Executed SQL statement ‘SELECT’, start retrieve records…
+0001 MSG_RETRIEVED2 status=‘DBM_SUCCESS’
+0001 rows retrieved (59)
+0001 MSG_RETRIEVED status=‘DBM_NOMORE’

18:11:06.746 Dbg 10741 ‘App (DataSourcer,genesys,13520)’ has put request id=‘527’ type=‘MSG_EXECSQL’ into queue
18:11:06.746 Dbg 10739 SELECT genesys.RAWTOHEX(STAT_TYPE_DEF) FROM OL_STAT_TYPE WHERE STAT_TYPE_NAME=‘AbandCallsPercentage’
18:11:06.746 Dbg 10737 Forwarding request ‘527’ from ‘App (DataSourcer,genesys,13520)’ to ‘MS SQL: 974.1’
18:11:06.747 Dbg 10743 ‘MS SQL: 974.1’ is spare
18:11:06.748 Dbg 10739 ODBC: id=‘974.1’ req=‘527’ SQL: SELECT genesys.RAWTOHEX(STAT_TYPE_DEF) FROM OL_STAT_TYPE WHERE STAT_TYPE_NAME=‘AbandCallsPercentage’
+0002 odbcerr: [Microsoft][ODBC SQL Server Driver][SQL Server]Cannot find either column “genesys” or the user-defined function or aggregate “genesys.RAWTOHEX”, or the name is ambiguous.
+0002 MSG_ERROR status=‘serverError’ msg='[Microsoft][ODBC SQL Server Driver][SQL Server]Cannot find either column “genesys” or the user-defined function or aggregate “genesys.RAWTOHEX”, or the name is ambiguous. ’

18:11:06.748 Dbg 10749 Forwarding response ‘527.1’ from ‘MS SQL: 974.1’ to ‘App (DataSourcer,genesys,13520)’
18:11:06.749 Std 04523 Connection to client ‘App (DataSourcer,genesys,13520)’ closed, reason ‘‘client disconnected’’
18:11:06.749 Dbg 10734 Send message ‘MSG_DISCONNECTED’ to ‘MS SQL: 974.1’, request id ‘-1’

Thanks in advance

cavagnaro · July 23, 2015, 4:32pm

Your ods won’t run with another user that is not db owner, maybe sa. Upgrade ods or configure that user role on dap.
Don’t remember the option right now, but if you do a search on Genesys support will find it.

Enviado de meu C6602 usando Tapatalk