1 2 3 Previous Next 39 Replies Latest reply on Jun 6, 2017 1:21 PM by scboyce Go to original post
      • 15. Re: ODBC Connecton to VDB
        romagnolli

        When I run a query against the VDB (select * FROM  "MS_SQL_AdventureWorks2016_view"."Employee") using SQuirreL SQL Client , who is using JDBC connection I see the following logs - the query is processed successfully:

        10:25:24,103 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #6) QmtNpM2Hj8a7     START USER COMMAND:    startTime=2017-01-13 10:25:24.103    requestID=QmtNpM2Hj8a7.10    txID=null    sessionID=QmtNpM2Hj8a7    applicationName=JDBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select * FROM  "MS_SQL_AdventureWorks2016_view"."Employee"

        10:25:24,108 DEBUG [org.teiid.COMMAND_LOG] (Worker9_QueryProcessorQueue76) QmtNpM2Hj8a7     START DATA SRC COMMAND:    startTime=2017-01-13 10:25:24.108    requestID=QmtNpM2Hj8a7.10    sourceCommandID=0    executionID=4    txID=null    modelName=MS_SQL_AdventureWorks2016_source    translatorName=sqlserver    sessionID=QmtNpM2Hj8a7    principal=teiid@teiid-security    sql=SELECT g_0.BusinessEntityID, g_0.NationalIDNumber, g_0.LoginID, g_0.OrganizationLevel, g_0.JobTitle, g_0.BirthDate, g_0.MaritalStatus, g_0.Gender, g_0.HireDate, g_0.VacationHours, g_0.SickLeaveHours, g_0.rowguid, g_0.ModifiedDate FROM MS_SQL_AdventureWorks2016_source.Employee AS g_0

        10:25:24,727 DEBUG [org.teiid.COMMAND_LOG] (Worker8_QueryProcessorQueue77) QmtNpM2Hj8a7     END SRC COMMAND:    endTime=2017-01-13 10:25:24.727    requestID=QmtNpM2Hj8a7.10    sourceCommandID=0    executionID=4    txID=null    modelName=MS_SQL_AdventureWorks2016_source    translatorName=sqlserver    sessionID=QmtNpM2Hj8a7    principal=teiid@teiid-security    finalRowCount=290

        10:25:24,752 DEBUG [org.teiid.COMMAND_LOG] (Worker9_QueryProcessorQueue79) QmtNpM2Hj8a7     END USER COMMAND:    endTime=2017-01-13 10:25:24.752    requestID=QmtNpM2Hj8a7.10    txID=null    sessionID=QmtNpM2Hj8a7    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=290

         

        When I try to create an ODBC query in Excel (trying to visualize data from "MS_SQL_AdventureWorks2016_view"."Shift" table), I see the following logs:

        10:42:15,574 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #29) dZNjr5iVN/6O     START USER COMMAND:    startTime=2017-01-13 10:42:15.574    requestID=dZNjr5iVN/6O.0    txID=null    sessionID=dZNjr5iVN/6O    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select teiid_session_set('resolve_groupby_positional', true)

        10:42:15,576 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #29) dZNjr5iVN/6O     END USER COMMAND:    endTime=2017-01-13 10:42:15.576    requestID=dZNjr5iVN/6O.0    txID=null    sessionID=dZNjr5iVN/6O    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:15,579 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #29) dZNjr5iVN/6O     START USER COMMAND:    startTime=2017-01-13 10:42:15.579    requestID=dZNjr5iVN/6O.1    txID=null    sessionID=dZNjr5iVN/6O    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select oid, typbasetype from pg_type where typname = 'lo'

        10:42:15,586 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue80) dZNjr5iVN/6O     START USER COMMAND:    startTime=2017-01-13 10:42:15.585    requestID=dZNjr5iVN/6O.2    txID=null    sessionID=dZNjr5iVN/6O    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:15,591 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue80) dZNjr5iVN/6O     END USER COMMAND:    endTime=2017-01-13 10:42:15.591    requestID=dZNjr5iVN/6O.2    txID=null    sessionID=dZNjr5iVN/6O    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:15,591 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue80) dZNjr5iVN/6O     START USER COMMAND:    startTime=2017-01-13 10:42:15.591    requestID=dZNjr5iVN/6O.3    txID=null    sessionID=dZNjr5iVN/6O    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:15,593 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue80) dZNjr5iVN/6O     END USER COMMAND:    endTime=2017-01-13 10:42:15.593    requestID=dZNjr5iVN/6O.3    txID=null    sessionID=dZNjr5iVN/6O    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:15,594 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue80) dZNjr5iVN/6O     END USER COMMAND:    endTime=2017-01-13 10:42:15.594    requestID=dZNjr5iVN/6O.1    txID=null    sessionID=dZNjr5iVN/6O    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:15,598 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #29) dZNjr5iVN/6O     START USER COMMAND:    startTime=2017-01-13 10:42:15.598    requestID=dZNjr5iVN/6O.4    txID=null    sessionID=dZNjr5iVN/6O    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select 63

        10:42:15,600 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue81) dZNjr5iVN/6O     END USER COMMAND:    endTime=2017-01-13 10:42:15.6    requestID=dZNjr5iVN/6O.4    txID=null    sessionID=dZNjr5iVN/6O    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:15,685 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #31) 3+P2rcM9AzsL     START USER COMMAND:    startTime=2017-01-13 10:42:15.685    requestID=3+P2rcM9AzsL.0    txID=null    sessionID=3+P2rcM9AzsL    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select teiid_session_set('resolve_groupby_positional', true)

        10:42:15,686 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #31) 3+P2rcM9AzsL     END USER COMMAND:    endTime=2017-01-13 10:42:15.686    requestID=3+P2rcM9AzsL.0    txID=null    sessionID=3+P2rcM9AzsL    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:15,688 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #31) 3+P2rcM9AzsL     START USER COMMAND:    startTime=2017-01-13 10:42:15.688    requestID=3+P2rcM9AzsL.1    txID=null    sessionID=3+P2rcM9AzsL    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select oid, typbasetype from pg_type where typname = 'lo'

        10:42:15,691 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue82) 3+P2rcM9AzsL     START USER COMMAND:    startTime=2017-01-13 10:42:15.691    requestID=3+P2rcM9AzsL.2    txID=null    sessionID=3+P2rcM9AzsL    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:15,692 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue82) 3+P2rcM9AzsL     END USER COMMAND:    endTime=2017-01-13 10:42:15.692    requestID=3+P2rcM9AzsL.2    txID=null    sessionID=3+P2rcM9AzsL    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:15,692 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue82) 3+P2rcM9AzsL     START USER COMMAND:    startTime=2017-01-13 10:42:15.692    requestID=3+P2rcM9AzsL.3    txID=null    sessionID=3+P2rcM9AzsL    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:15,693 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue82) 3+P2rcM9AzsL     END USER COMMAND:    endTime=2017-01-13 10:42:15.693    requestID=3+P2rcM9AzsL.3    txID=null    sessionID=3+P2rcM9AzsL    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:15,694 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue82) 3+P2rcM9AzsL     END USER COMMAND:    endTime=2017-01-13 10:42:15.694    requestID=3+P2rcM9AzsL.1    txID=null    sessionID=3+P2rcM9AzsL    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:15,697 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #31) 3+P2rcM9AzsL     START USER COMMAND:    startTime=2017-01-13 10:42:15.697    requestID=3+P2rcM9AzsL.4    txID=null    sessionID=3+P2rcM9AzsL    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select NULL, NULL, NULL

        10:42:15,699 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue83) 3+P2rcM9AzsL     END USER COMMAND:    endTime=2017-01-13 10:42:15.699    requestID=3+P2rcM9AzsL.4    txID=null    sessionID=3+P2rcM9AzsL    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:18,784 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #2) fTv1FmO/PvoG     START USER COMMAND:    startTime=2017-01-13 10:42:18.784    requestID=fTv1FmO/PvoG.0    txID=null    sessionID=fTv1FmO/PvoG    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select teiid_session_set('resolve_groupby_positional', true)

        10:42:18,785 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #2) fTv1FmO/PvoG     END USER COMMAND:    endTime=2017-01-13 10:42:18.785    requestID=fTv1FmO/PvoG.0    txID=null    sessionID=fTv1FmO/PvoG    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:18,787 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #2) fTv1FmO/PvoG     START USER COMMAND:    startTime=2017-01-13 10:42:18.786    requestID=fTv1FmO/PvoG.1    txID=null    sessionID=fTv1FmO/PvoG    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select oid, typbasetype from pg_type where typname = 'lo'

        10:42:18,789 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue84) fTv1FmO/PvoG     START USER COMMAND:    startTime=2017-01-13 10:42:18.789    requestID=fTv1FmO/PvoG.2    txID=null    sessionID=fTv1FmO/PvoG    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:18,790 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue84) fTv1FmO/PvoG     END USER COMMAND:    endTime=2017-01-13 10:42:18.79    requestID=fTv1FmO/PvoG.2    txID=null    sessionID=fTv1FmO/PvoG    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:18,791 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue84) fTv1FmO/PvoG     START USER COMMAND:    startTime=2017-01-13 10:42:18.791    requestID=fTv1FmO/PvoG.3    txID=null    sessionID=fTv1FmO/PvoG    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:18,791 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue84) fTv1FmO/PvoG     END USER COMMAND:    endTime=2017-01-13 10:42:18.791    requestID=fTv1FmO/PvoG.3    txID=null    sessionID=fTv1FmO/PvoG    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:18,792 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue84) fTv1FmO/PvoG     END USER COMMAND:    endTime=2017-01-13 10:42:18.792    requestID=fTv1FmO/PvoG.1    txID=null    sessionID=fTv1FmO/PvoG    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:18,792 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #2) fTv1FmO/PvoG     START USER COMMAND:    startTime=2017-01-13 10:42:18.792    requestID=fTv1FmO/PvoG.4    txID=null    sessionID=fTv1FmO/PvoG    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select relname, nspname, relkind from pg_catalog.pg_class c, pg_catalog.pg_namespace n where relkind in ('r', 'v') and nspname not in ('pg_catalog', 'information_schema', 'pg_toast', 'pg_temp_1') and n.oid = relnamespace order by nspname, relname

        10:42:18,799 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue85) fTv1FmO/PvoG     START USER COMMAND:    startTime=2017-01-13 10:42:18.798    requestID=fTv1FmO/PvoG.5    txID=null    sessionID=fTv1FmO/PvoG    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:18,799 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue85) fTv1FmO/PvoG     END USER COMMAND:    endTime=2017-01-13 10:42:18.799    requestID=fTv1FmO/PvoG.5    txID=null    sessionID=fTv1FmO/PvoG    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:18,800 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue85) fTv1FmO/PvoG     START USER COMMAND:    startTime=2017-01-13 10:42:18.8    requestID=fTv1FmO/PvoG.6    txID=null    sessionID=fTv1FmO/PvoG    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:18,800 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue85) fTv1FmO/PvoG     END USER COMMAND:    endTime=2017-01-13 10:42:18.8    requestID=fTv1FmO/PvoG.6    txID=null    sessionID=fTv1FmO/PvoG    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:18,801 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue85) fTv1FmO/PvoG     START USER COMMAND:    startTime=2017-01-13 10:42:18.801    requestID=fTv1FmO/PvoG.7    txID=null    sessionID=fTv1FmO/PvoG    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:18,801 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue85) fTv1FmO/PvoG     END USER COMMAND:    endTime=2017-01-13 10:42:18.801    requestID=fTv1FmO/PvoG.7    txID=null    sessionID=fTv1FmO/PvoG    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:18,804 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue85) fTv1FmO/PvoG     END USER COMMAND:    endTime=2017-01-13 10:42:18.804    requestID=fTv1FmO/PvoG.4    txID=null    sessionID=fTv1FmO/PvoG    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=42

        10:42:25,819 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #4) xQipG0+3mDJ8     START USER COMMAND:    startTime=2017-01-13 10:42:25.819    requestID=xQipG0+3mDJ8.0    txID=null    sessionID=xQipG0+3mDJ8    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select teiid_session_set('resolve_groupby_positional', true)

        10:42:25,821 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #4) xQipG0+3mDJ8     END USER COMMAND:    endTime=2017-01-13 10:42:25.821    requestID=xQipG0+3mDJ8.0    txID=null    sessionID=xQipG0+3mDJ8    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,823 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #4) xQipG0+3mDJ8     START USER COMMAND:    startTime=2017-01-13 10:42:25.823    requestID=xQipG0+3mDJ8.1    txID=null    sessionID=xQipG0+3mDJ8    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select oid, typbasetype from pg_type where typname = 'lo'

        10:42:25,828 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue86) xQipG0+3mDJ8     START USER COMMAND:    startTime=2017-01-13 10:42:25.828    requestID=xQipG0+3mDJ8.2    txID=null    sessionID=xQipG0+3mDJ8    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,831 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue86) xQipG0+3mDJ8     END USER COMMAND:    endTime=2017-01-13 10:42:25.831    requestID=xQipG0+3mDJ8.2    txID=null    sessionID=xQipG0+3mDJ8    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,831 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue86) xQipG0+3mDJ8     START USER COMMAND:    startTime=2017-01-13 10:42:25.831    requestID=xQipG0+3mDJ8.3    txID=null    sessionID=xQipG0+3mDJ8    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,832 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue86) xQipG0+3mDJ8     END USER COMMAND:    endTime=2017-01-13 10:42:25.832    requestID=xQipG0+3mDJ8.3    txID=null    sessionID=xQipG0+3mDJ8    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,834 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue86) xQipG0+3mDJ8     END USER COMMAND:    endTime=2017-01-13 10:42:25.834    requestID=xQipG0+3mDJ8.1    txID=null    sessionID=xQipG0+3mDJ8    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,834 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #4) xQipG0+3mDJ8     START USER COMMAND:    startTime=2017-01-13 10:42:25.834    requestID=xQipG0+3mDJ8.4    txID=null    sessionID=xQipG0+3mDJ8    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select 63

        10:42:25,838 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue87) xQipG0+3mDJ8     END USER COMMAND:    endTime=2017-01-13 10:42:25.838    requestID=xQipG0+3mDJ8.4    txID=null    sessionID=xQipG0+3mDJ8    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,849 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #5) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.849    requestID=mg69fjzznKHO.0    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select teiid_session_set('resolve_groupby_positional', true)

        10:42:25,851 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #5) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.851    requestID=mg69fjzznKHO.0    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,855 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #5) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.855    requestID=mg69fjzznKHO.1    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select oid, typbasetype from pg_type where typname = 'lo'

        10:42:25,860 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue88) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.86    requestID=mg69fjzznKHO.2    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,861 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue88) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.861    requestID=mg69fjzznKHO.2    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,862 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue88) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.862    requestID=mg69fjzznKHO.3    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,863 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue88) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.863    requestID=mg69fjzznKHO.3    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,864 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue88) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.864    requestID=mg69fjzznKHO.1    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,867 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #5) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.867    requestID=mg69fjzznKHO.4    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select n.nspname, c.relname, a.attname, a.atttypid, t.typname, a.attnum, a.attlen, a.atttypmod, a.attnotnull, c.relhasrules, c.relkind, c.oid, pg_get_expr(d.adbin, d.adrelid), case t.typtype when 'd' then t.typbasetype else 0 end, t.typtypmod, c.relhasoids from (((pg_catalog.pg_class c inner join pg_catalog.pg_namespace n on n.oid = c.relnamespace and c.relname like 'Shift' and n.nspname like 'MS\_SQL\_AdventureWorks2016\_view') inner join pg_catalog.pg_attribute a on (not a.attisdropped) and a.attnum > 0 and a.attrelid = c.oid) inner join pg_catalog.pg_type t on t.oid = a.atttypid) left outer join pg_attrdef d on a.atthasdef and d.adrelid = a.attrelid and d.adnum = a.attnum order by n.nspname, c.relname, attnum

        10:42:25,886 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.886    requestID=mg69fjzznKHO.5    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,886 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.886    requestID=mg69fjzznKHO.5    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,887 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.887    requestID=mg69fjzznKHO.6    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,888 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.888    requestID=mg69fjzznKHO.6    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,888 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.888    requestID=mg69fjzznKHO.7    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,888 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.888    requestID=mg69fjzznKHO.7    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,889 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.889    requestID=mg69fjzznKHO.8    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,889 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.889    requestID=mg69fjzznKHO.8    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,889 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.889    requestID=mg69fjzznKHO.9    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,890 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.89    requestID=mg69fjzznKHO.9    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,890 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.89    requestID=mg69fjzznKHO.10    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,891 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.891    requestID=mg69fjzznKHO.10    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,891 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.891    requestID=mg69fjzznKHO.11    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,891 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.891    requestID=mg69fjzznKHO.11    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,892 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.892    requestID=mg69fjzznKHO.12    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,893 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.893    requestID=mg69fjzznKHO.12    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,893 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.893    requestID=mg69fjzznKHO.13    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,893 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.893    requestID=mg69fjzznKHO.13    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,894 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.894    requestID=mg69fjzznKHO.14    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,894 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.894    requestID=mg69fjzznKHO.14    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,894 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.894    requestID=mg69fjzznKHO.15    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,895 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.895    requestID=mg69fjzznKHO.15    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,895 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.895    requestID=mg69fjzznKHO.16    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,895 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.895    requestID=mg69fjzznKHO.16    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,896 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.896    requestID=mg69fjzznKHO.17    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,896 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.896    requestID=mg69fjzznKHO.17    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,896 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     START USER COMMAND:    startTime=2017-01-13 10:42:25.896    requestID=mg69fjzznKHO.18    txID=null    sessionID=mg69fjzznKHO    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,897 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.897    requestID=mg69fjzznKHO.18    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,897 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue89) mg69fjzznKHO     END USER COMMAND:    endTime=2017-01-13 10:42:25.897    requestID=mg69fjzznKHO.4    txID=null    sessionID=mg69fjzznKHO    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=0

        10:42:25,907 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #7) 6o6brpnHy8dE     START USER COMMAND:    startTime=2017-01-13 10:42:25.907    requestID=6o6brpnHy8dE.0    txID=null    sessionID=6o6brpnHy8dE    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select teiid_session_set('resolve_groupby_positional', true)

        10:42:25,909 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #7) 6o6brpnHy8dE     END USER COMMAND:    endTime=2017-01-13 10:42:25.909    requestID=6o6brpnHy8dE.0    txID=null    sessionID=6o6brpnHy8dE    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,911 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #7) 6o6brpnHy8dE     START USER COMMAND:    startTime=2017-01-13 10:42:25.911    requestID=6o6brpnHy8dE.1    txID=null    sessionID=6o6brpnHy8dE    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select oid, typbasetype from pg_type where typname = 'lo'

        10:42:25,915 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue90) 6o6brpnHy8dE     START USER COMMAND:    startTime=2017-01-13 10:42:25.915    requestID=6o6brpnHy8dE.2    txID=null    sessionID=6o6brpnHy8dE    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,916 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue90) 6o6brpnHy8dE     END USER COMMAND:    endTime=2017-01-13 10:42:25.916    requestID=6o6brpnHy8dE.2    txID=null    sessionID=6o6brpnHy8dE    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,917 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue90) 6o6brpnHy8dE     START USER COMMAND:    startTime=2017-01-13 10:42:25.917    requestID=6o6brpnHy8dE.3    txID=null    sessionID=6o6brpnHy8dE    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,917 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue90) 6o6brpnHy8dE     END USER COMMAND:    endTime=2017-01-13 10:42:25.917    requestID=6o6brpnHy8dE.3    txID=null    sessionID=6o6brpnHy8dE    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,919 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue90) 6o6brpnHy8dE     END USER COMMAND:    endTime=2017-01-13 10:42:25.919    requestID=6o6brpnHy8dE.1    txID=null    sessionID=6o6brpnHy8dE    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,922 DEBUG [org.teiid.COMMAND_LOG] (New I/O worker #7) 6o6brpnHy8dE     START USER COMMAND:    startTime=2017-01-13 10:42:25.922    requestID=6o6brpnHy8dE.4    txID=null    sessionID=6o6brpnHy8dE    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=SELECT k.Name AS attname, convert(Position, short) AS attnum, TableName AS relname, SchemaName AS nspname, TableName AS relname FROM SYS.KeyColumns k WHERE  UCASE(SchemaName) LIKE UCASE('MS_SQL_AdventureWorks2016_view') AND UCASE(TableName) LIKE UCASE('Shift') AND KeyType LIKE 'Primary' ORDER BY attnum

        10:42:25,925 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue91) 6o6brpnHy8dE     START USER COMMAND:    startTime=2017-01-13 10:42:25.925    requestID=6o6brpnHy8dE.5    txID=null    sessionID=6o6brpnHy8dE    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,925 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue91) 6o6brpnHy8dE     END USER COMMAND:    endTime=2017-01-13 10:42:25.925    requestID=6o6brpnHy8dE.5    txID=null    sessionID=6o6brpnHy8dE    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,925 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue91) 6o6brpnHy8dE     START USER COMMAND:    startTime=2017-01-13 10:42:25.925    requestID=6o6brpnHy8dE.6    txID=null    sessionID=6o6brpnHy8dE    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,926 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue91) 6o6brpnHy8dE     END USER COMMAND:    endTime=2017-01-13 10:42:25.926    requestID=6o6brpnHy8dE.6    txID=null    sessionID=6o6brpnHy8dE    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,926 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue91) 6o6brpnHy8dE     START USER COMMAND:    startTime=2017-01-13 10:42:25.926    requestID=6o6brpnHy8dE.7    txID=null    sessionID=6o6brpnHy8dE    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,927 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue91) 6o6brpnHy8dE     END USER COMMAND:    endTime=2017-01-13 10:42:25.927    requestID=6o6brpnHy8dE.7    txID=null    sessionID=6o6brpnHy8dE    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,927 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue91) 6o6brpnHy8dE     START USER COMMAND:    startTime=2017-01-13 10:42:25.927    requestID=6o6brpnHy8dE.8    txID=null    sessionID=6o6brpnHy8dE    applicationName=ODBC    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    sql=select attrelid, attnum, typoid from matpg_relatt where attname = ? and relname = ? and nspname = ?

        10:42:25,927 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue91) 6o6brpnHy8dE     END USER COMMAND:    endTime=2017-01-13 10:42:25.927    requestID=6o6brpnHy8dE.8    txID=null    sessionID=6o6brpnHy8dE    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        10:42:25,928 DEBUG [org.teiid.COMMAND_LOG] (Worker10_QueryProcessorQueue91) 6o6brpnHy8dE     END USER COMMAND:    endTime=2017-01-13 10:42:25.928    requestID=6o6brpnHy8dE.4    txID=null    sessionID=6o6brpnHy8dE    principal=teiid@teiid-security    vdbName=AdventureWorks2016    vdbVersion=1    finalRowCount=1

        • 16. Re: ODBC Connecton to VDB
          rareddy

          Could you provide a minimal VDB that exhibits this behavior? I have to recreate the issue locally to suggest any further steps.

          • 17. Re: ODBC Connecton to VDB
            romagnolli

            My VDB (called AdventureWorks2016.vdb) is very simple - it contains only 2 views: "MS_SQL_AdventureWorks2016_source.xmi" (which is a source model) and "MS_SQL_AdventureWorks2016_view.xmi" (which is a view model).

            The source model is importing data from AdventureWorks2016 database, which is MS SQL Server 2016.

            I made the connection to the MS SQL Server using Generic JDBC Driver - I've downloaded the latest version of the SQL Server JDBC Driver - sqljdbc42.jar.

            13 tables are imported from the SQL Server database:

            [HumanResources].[Department]

            [HumanResources].[Employee]

            [HumanResources].[EmployeeDepartmentHistory]

            [HumanResources].[Shift]

            [Person].[BusinessEntity]

            [Person].[Address]

            [Person].[AddressType]

            [Person].[BusinessEntityAddress]

            [Person].[CountryRegion]

            [Person].[EmailAddress]

            [Person].[Person]

            [Person].[PersonPhone]

            [Person].[PhoneNumberType]

            [Person].[StateProvince]

             

            Then the view model is created - without any modifications on the source data. VDB is created and deployed successfully on the server. Then I tested the connection to the VDB using SQuirreL SQL client (JDBC connection) - everything is OK. Then tested the connection using MS Access (ODBC connection) - everything is OK. But using the same ODBC connection gave the error message with the "missing columns in the tables".....

             

            I'm not an expert , but suspect that the Teiid user cannot access the SYS schema of my VDB - look at this row in my log file: "sql=SELECT k.Name AS attname, convert(Position, short) AS attnum, TableName AS relname, SchemaName AS nspname, TableName AS relname FROM SYS.KeyColumns k WHERE  UCASE(SchemaName) LIKE UCASE('MS_SQL_AdventureWorks2016_view') AND UCASE(TableName) LIKE UCASE('Shift') AND KeyType LIKE 'Primary' ORDER BY attnum".

            I was using the same user for the connection with JDBC (SQuirreL) and ODBC (MS Access).

            This user is created with the help of the add-user.bat. The user has "Application User" type....

            • 18. Re: ODBC Connecton to VDB
              rareddy

              It would be easy for me if you can provide me a working VDB.

              • 19. Re: ODBC Connecton to VDB
                romagnolli

                You need only the ".vdb" file ? And how can I provide it to you - I don't see an option to attach a file to my message....?

                • 20. Re: ODBC Connecton to VDB
                  rareddy

                  Yes, use advance editor it will give you an option to attach the file. Preferably export the .vdb as the -vdb.xml file, then attach.

                  • 21. Re: ODBC Connecton to VDB
                    romagnolli

                    This is my .vdb. I can't find the way to export it as XML....

                    • 22. Re: ODBC Connecton to VDB
                      romagnolli

                      Hi Ramesh,

                      Do you have any progress on that issue...?

                       

                      Thanks in advance

                      Ivan

                      • 23. Re: ODBC Connecton to VDB
                        romagnolli

                        Hi Ramesh,

                        I've attached my whole Teiid Model Project...

                        In PowerPivot I also have issues using the DSN.....

                        • 24. Re: ODBC Connecton to VDB
                          rareddy

                          I am having difficulty in securing Excel for testing. Can you post the error you see in above dialog.

                          • 25. Re: ODBC Connecton to VDB
                            romagnolli

                            ERROR [50000] ERROR: TEIID31100 Parsing error: Encountered "SELECT [*][[*]BT_EQUIPMENTORDER]" at line 1, column 10.

                            Was expecting: "char" | "cast" | "convert" | "all" | "any" | "array_agg" | "case" | "distinct" | "exists" | "false" ...;

                            No query has been executed with that handle

                            • 26. Re: ODBC Connecton to VDB
                              rareddy

                              Can you see the server.log and post the full error. Also if there is no stack, turn on the debugging on Teiid server then execute the query. From what I can tell Excel is generating a query that is not ANSI compatible or not standard, but I can confirm it when I see the full error. You can also turn on COMMAND_LOG on Teiid side to get the exact query that has been submitted too.

                              • 27. Re: ODBC Connecton to VDB
                                romagnolli

                                In the attached file is the Teiid_Command_Log - you can search for the word "Department" (in order to find the full query text) - this is the name of the table that I try to import in PowerPivot....

                                In server.log there are no records related to this error....

                                • 28. Re: ODBC Connecton to VDB
                                  rareddy

                                  I do not see the offending query in command_log, it never made through the parser layer, if the server logs in DEBUG mode, you should see in server.log.

                                  • 29. Re: ODBC Connecton to VDB
                                    romagnolli

                                    I made another test - I tried to export data from a table called "PhoneNumberType" and here are all the logs that I managed to collect:

                                    It's interesting that if I choose the option to write my own SELECT statement instead of selecting tables with checkboxes - everything goes well...

                                     

                                    Looks like the wizard is throwing SELECT [*][[*]MSSQLServerAdventureWorksview]

                                    instead of

                                    SELECT * FROM MSSQLServerAdventureWorksview.PhoneNumberType

                                     

                                     

                                    server.log

                                    11:06:59,190 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue0) TEIID30013 Loading materialized view table #MAT_PG_CATALOG.PG_TYPE

                                    11:06:59,233 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue2) TEIID30014 Loaded materialized view table #MAT_PG_CATALOG.PG_TYPE with row count 37.

                                    11:06:59,253 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue2) TEIID30013 Loading materialized view table #MAT_PG_CATALOG.MATPG_RELATT

                                    11:06:59,284 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue2) TEIID30013 Loading materialized view table #MAT_PG_CATALOG.PG_ATTRIBUTE

                                    11:06:59,303 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue2) TEIID30013 Loading materialized view table #MAT_PG_CATALOG.MATPG_DATATYPE

                                    11:06:59,321 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue2) TEIID30014 Loaded materialized view table #MAT_PG_CATALOG.MATPG_DATATYPE with row count 18.

                                    11:06:59,387 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue2) TEIID30014 Loaded materialized view table #MAT_PG_CATALOG.PG_ATTRIBUTE with row count 498.

                                    11:06:59,401 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue2) TEIID30013 Loading materialized view table #MAT_PG_CATALOG.PG_CLASS

                                    11:06:59,417 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue2) TEIID30014 Loaded materialized view table #MAT_PG_CATALOG.PG_CLASS with row count 113.

                                    11:06:59,507 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue2) TEIID30014 Loaded materialized view table #MAT_PG_CATALOG.MATPG_RELATT with row count 398.

                                    11:07:31,733 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue10) TEIID30013 Loading materialized view table #MAT_PG_CATALOG.PG_INDEX

                                    11:07:31,802 INFO  [org.teiid.PROCESSOR.MATVIEWS] (Worker0_QueryProcessorQueue10) TEIID30014 Loaded materialized view table #MAT_PG_CATALOG.PG_INDEX with row count 89.

                                    11:07:35,671 WARN  [org.teiid.PROCESSOR] (Worker0_QueryProcessorQueue12) TEIID30020 Processing exception for request KXaPs8w95zD3.4 'TEIID31100 Parsing error: Encountered "SELECT [*][[*]MSSQLServerAdventureWorksview]" at line 1, column 8.

                                    Was expecting: "char" | "cast" | "convert" | "all" | "any" | "array_agg" | "case" | "distinct" | "exists" | "false" ...'. Originally QueryParserException QueryParser.java:214. Enable more detailed logging to see the entire stacktrace.

                                     

                                    teiid_command_log and ODBC.log are in the attached files.