c:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp>mvn gwt:run
[INFO] Scanning for projects...
[INFO] ------------------------------------------------------------------------
[INFO] Building CsmpApp
[INFO]    task-segment: [gwt:run]
[INFO] ------------------------------------------------------------------------
[INFO] Preparing gwt:run
[INFO] [resources:resources {execution: default-resources}]
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] Copying 6 resources
[INFO] [compiler:compile {execution: default-compile}]
[INFO] Nothing to compile - all classes are up to date
[INFO] [gwt:run {execution: default-cli}]
[INFO] create exploded Jetty webapp in c:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1
[INFO] auto discovered modules [com.cogeco.csmp.gwt.CsmpApp]
[INFO] ISC: Configuring log4j from: file:/C:/cogeco/acbisUpgrade/workspace/CustomerServiceManagementProvisioning/CsmpApp/target/CsmpApp-0.1/WEB-INF/classes/log4j.isc.config.xml
[INFO] === 2010-12-06 11:38:23,569 [main] INFO  ISCInit - Isomorphic SmartClient Framework - Initializing
[INFO] === 2010-12-06 11:38:23,578 [main] INFO  ConfigLoader - Attempting to load framework.properties from CLASSPATH
[INFO] === 2010-12-06 11:38:23,649 [main] INFO  ConfigLoader - Successfully loaded framework.properties from CLASSPATH at location: jar:file:/C:/cogeco/acbisUpgrade/workspace/CustomerServiceManagementProvisioning/CsmpApp/target/CsmpApp-0.1/WEB-INF/lib/isomorphic_core_rpc.jar!/framework.properties
[INFO] === 2010-12-06 11:38:23,649 [main] INFO  ConfigLoader - Attempting to load project.properties from CLASSPATH
[INFO] === 2010-12-06 11:38:23,650 [main] INFO  ConfigLoader - Unable to locate project.properties in CLASSPATH
[INFO] === 2010-12-06 11:38:23,655 [main] INFO  ConfigLoader - Successfully loaded isc_interfaces.properties from CLASSPATH at location: jar:file:/C:/cogeco/acbisUpgrade/workspace/CustomerServiceManagementProvisioning/CsmpApp/target/CsmpApp-0.1/WEB-INF/lib/isomorphic_core_rpc.jar!/isc_interfaces.properties
[INFO] === 2010-12-06 11:38:23,656 [main] INFO  ConfigLoader - Attempting to load server.properties from CLASSPATH
[INFO] === 2010-12-06 11:38:23,658 [main] INFO  ConfigLoader - Successfully loaded server.properties from CLASSPATH at location: file:/C:/cogeco/acbisUpgrade/workspace/CustomerServiceManagementProvisioning/CsmpApp/target/CsmpApp-0.1/WEB-INF/classes/server.properties
[INFO] === 2010-12-06 11:38:23,664 [main] INFO  Logger - Logging system started.
[INFO] === 2010-12-06 11:38:23,665 [main] INFO  ISCInit - Isomorphic SmartClient Framework (SC_SNAPSHOT-2010-08-03/Pro Deployment 2010-08-03) - Initialization Complete
[INFO] === 2010-12-06 11:38:23,668 [main] INFO  ISCInit - Auto-detected webRoot - using: C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1
[INFO] === 2010-12-06 11:38:23,686 [main] INFO  PreCache - Isomorphic PreCache servlet loading
[INFO] === 2010-12-06 11:38:23,703 [main] INFO  PoolManager - SmartClient pooling disabled for 'DataSource' objects
[INFO] === 2010-12-06 11:38:23,757 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\DataSource.ds.xml: 7ms
[INFO] === 2010-12-06 11:38:23,766 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\builtinTypes.xml: 5ms
[INFO] === 2010-12-06 11:38:23,832 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\DataSourceField.ds.xml: 4ms
[INFO] === 2010-12-06 11:38:23,858 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\Validator.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:23,870 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\ValueMap.ds.xml: 1ms
[INFO] === 2010-12-06 11:38:23,878 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\InstantDataApp.ds.xml: 4ms
[INFO] === 2010-12-06 11:38:23,918 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\Application.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:23,923 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\IDAPage.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:23,930 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\IDAUserType.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:23,943 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\IDAOperation.ds.xml: 7ms
[INFO] === 2010-12-06 11:38:23,961 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\Canvas.ds.xml: 9ms
[INFO] === 2010-12-06 11:38:23,994 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\MethodDeclaration.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:24,000 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\Img.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:24,008 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\StatefulCanvas.ds.xml: 3ms
[INFO] === 2010-12-06 11:38:24,019 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\Button.ds.xml: 1ms
[INFO] === 2010-12-06 11:38:24,029 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\ListViewer.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:24,036 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\ListGrid.ds.xml: 5ms
[INFO] === 2010-12-06 11:38:24,062 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\DynamicForm.ds.xml: 3ms
[INFO] === 2010-12-06 11:38:24,074 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\FormItem.ds.xml: 3ms
[INFO] === 2010-12-06 11:38:24,087 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\DetailViewer.ds.xml: 3ms
[INFO] === 2010-12-06 11:38:24,099 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\DetailViewerField.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:24,104 [main] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\isomorphicXML.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:24,106 [main] INFO  PreCache - Isomorphic PreCache complete (420ms)
[INFO] === 2010-12-06 11:38:35,419 [l0-2] INFO  Download - Returning 304: Not modified on conditional get of: C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\skins\Enterprise\load_skin.js
[INFO] === 2010-12-06 11:38:35,839 [l0-2] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\ds\user.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:35,847 [l0-2] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\ServerObject.ds.xml: 3ms
[INFO] === 2010-12-06 11:38:35,861 [l0-2] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\ds\auditLog.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:35,866 [l0-2] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\ds\ficheClientDs.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:35,872 [l0-2] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\OperationBinding.ds.xml: 2ms
[INFO] === 2010-12-06 11:38:35,940 [l0-2] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\ds\pochetteDs.ds.xml: 1ms
[INFO] === 2010-12-06 11:38:53,497 [l0-2] INFO  RequestContext - URL: '/csmpapp/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 6.0; en-US) AppleWebKit/534.12 (KHTML, like Gecko) Chrome/9.0.587.0 Safari/534.12': Safari with Accept-Encoding header
[INFO] === 2010-12-06 11:38:53,529 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 3ms
[INFO] === 2010-12-06 11:38:53,535 [l0-2] DEBUG XML - Parsed XML from C:\cogeco\acbisUpgrade\workspace\CustomerServiceManagementProvisioning\CsmpApp\target\CsmpApp-0.1\csmpapp\sc\system\schema\List.ds.xml: 3ms
[INFO] === 2010-12-06 11:38:53,541 [l0-2] DEBUG RPCManager - Processing 1 requests.
[INFO] === 2010-12-06 11:38:53,557 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
[INFO]     criteria:{
[INFO]     },
[INFO]     operationConfig:{
[INFO]         dataSource:"user",
[INFO]         operationType:"fetch",
[INFO]         textMatchStyle:"exact"
[INFO]     },
[INFO]     startRow:0,
[INFO]     endRow:75,
[INFO]     componentId:"isc_ListGrid_0",
[INFO]     appID:"builtinApplication",
[INFO]     operation:"user_fetch",
[INFO]     oldValues:{
[INFO]     }
[INFO] }
[INFO] === 2010-12-06 11:38:53,566 [l0-2] INFO  IDACall - Performing 1 operation(s)
[ERROR] 2010-12-06 11:38:53 com.cogeco.csmp.gwt.server.datasource.UserDmi fetch
[ERROR] INFO: UserDmi.fetch = t_csmp_RO (R--)
[INFO] === 2010-12-06 11:38:53,618 [l0-2] INFO  DSResponse - DSResponse: List with 1 items
[INFO] === 2010-12-06 11:38:53,620 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
[INFO] === 2010-12-06 11:38:53,621 [l0-2] DEBUG RPCManager - DMI response, dropExtraFields: true
[ERROR] 2010-12-06 11:38:53 com.cogeco.csmp.gwt.server.datasource.UserDmi fetch
[ERROR] INFO: UserDmi.fetch completed
[INFO] Mon Dec 06 11:38:53 EST 2010 com.cogeco.csmp.gwt.client.GwtClientHelper
[INFO] INFO: AUDITLOG (ui) 5965645: Ouverture du client [5965645]
[INFO] === 2010-12-06 11:38:53,814 [l0-2] INFO  RequestContext - URL: '/csmpapp/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 6.0; en-US) AppleWebKit/534.12 (KHTML, like Gecko) Chrome/9.0.587.0 Safari/534.12': Safari with Accept-Encoding header
[INFO] === 2010-12-06 11:38:53,825 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 4ms
[INFO] === 2010-12-06 11:38:53,830 [l0-2] DEBUG RPCManager - Processing 1 requests.
[INFO] === 2010-12-06 11:38:53,831 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
[INFO]     values:{
[INFO]         __gwt_ObjectId:118,
[ERROR] 2010-12-06 11:38:53 com.cogeco.csmp.gwt.server.GwtServerHelper auditLog
[ERROR] INFO: AUDITLOG (server) t_csmp_RO 5965645: Ouverture du client [5965645]
[INFO]         client:"5965645",
[INFO]         message:"Ouverture du client [5965645]"
[INFO]     },
[INFO]     operationConfig:{
[INFO]         dataSource:"auditLog",
[INFO]         operationType:"add"
[INFO]     },
[INFO]     appID:"builtinApplication",
[INFO]     operation:"auditLog_add",
[INFO]     oldValues:{
[INFO]         __gwt_ObjectId:118,
[INFO]         client:"5965645",
[INFO]         message:"Ouverture du client [5965645]"
[INFO]     },
[INFO]     criteria:{
[INFO]     }
[INFO] }
[INFO] === 2010-12-06 11:38:53,833 [l0-2] INFO  IDACall - Performing 1 operation(s)
[INFO] === 2010-12-06 11:38:53,838 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
[INFO] === 2010-12-06 11:38:53,839 [l0-2] DEBUG RPCManager - DMI response, dropExtraFields: true
[INFO] === 2010-12-06 11:38:54,379 [l0-2] INFO  RequestContext - URL: '/csmpapp/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 6.0; en-US) AppleWebKit/534.12 (KHTML, like Gecko) Chrome/9.0.587.0 Safari/534.12': Safari with Accept-Encoding header
[INFO] === 2010-12-06 11:38:54,386 [l0-2] DEBUG XML - Parsed XML from (in memory stream): 3ms
[INFO] === 2010-12-06 11:38:54,389 [l0-2] DEBUG RPCManager - Processing 1 requests.
[INFO] === 2010-12-06 11:38:54,390 [l0-2] DEBUG RPCManager - Request #1 (DSRequest) payload: {
[INFO]     criteria:{
[INFO]         __gwt_ObjectId:197,
[INFO]         cl_no_as400:"5965645"
[INFO]     },
[INFO]     operationConfig:{
[INFO]         dataSource:"ficheClientDs",
[INFO]         operationType:"fetch"
[INFO]     },
[INFO]     componentId:"isc_DynamicForm_0",
[INFO]     appID:"builtinApplication",
[INFO]     operation:"ficheClientDs_fetch",
[INFO]     oldValues:{
[INFO]         __gwt_ObjectId:197,
[INFO]         cl_no_as400:"5965645"
[INFO]     }
[INFO] }
[INFO] === 2010-12-06 11:38:54,391 [l0-2] INFO  IDACall - Performing 1 operation(s)
[INFO] === 2010-12-06 11:38:54,393 [l0-2] DEBUG AppBase - [builtinApplication.ficheClientDs_fetch] No userTypes defined, allowing anyone access to all operations for this application
[INFO] === 2010-12-06 11:38:54,394 [l0-2] DEBUG AppBase - [builtinApplication.ficheClientDs_fetch] No public zero-argument method named '_ficheClientDs_fetch' found, performing generic datasource operation
[INFO] === 2010-12-06 11:38:54,395 [l0-2] INFO  SQLDataSource - [builtinApplication.ficheClientDs_fetch] Performing fetch operation with
[INFO]  criteria: {__gwt_ObjectId:197,cl_no_as400:"5965645"}    values: {__gwt_ObjectId:197,cl_no_as400:"5965645"}
[INFO] === 2010-12-06 11:38:54,510 [l0-2] INFO  SQLDataSource - [builtinApplication.ficheClientDs_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause
[INFO] === 2010-12-06 11:38:54,879 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.ficheClientDs_fetch] Initializing SQL config for 'SQLServer' from system config - using DriverManager:  net.sourceforge.jtds.jdbc.Driver
[INFO] === 2010-12-06 11:38:54,888 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.ficheClientDs_fetch] net.sourceforge.jtds.jdbc.Driver lookup successful
[INFO] === 2010-12-06 11:38:54,888 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.ficheClientDs_fetch] DriverManager fetching connection for SQLServer via jdbc url jdbc:jtds:sqlserver://TRDWSQLTEST:4002;DatabaseName=internetD1;User=application@app.cogeco.com;Password=G760oW03r5dic
[INFO] === 2010-12-06 11:38:54,888 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.ficheClientDs_fetch] Passing JDBC URL only to getConnection
[INFO] === 2010-12-06 11:38:55,089 [l0-2] DEBUG PoolableSQLConnectionFactory - [builtinApplication.ficheClientDs_fetch] Returning pooled Connection
[INFO] === 2010-12-06 11:38:55,098 [l0-2] INFO  SQLDriver - [builtinApplication.ficheClientDs_fetch] Executing SQL query on 'SQLServer': SELECT client.cl_ville, client.cl_nom_conjoint, client.cl_appartement, client.cl_langue, client.po_code, client.cl_revendeur, client.cl_rue, client.cl_telephone, client.co_code, client.cl_type_tarif, client.cl_code_postal, client.cl_telecopieur, client.cl_statut_as400, client.cl_no_civique, client.cl_id_info1, client.cl_type_client, client.cl_id_info2, client.he_code, client.di_code, client.cl_no_as400 FROM client WHERE (client.cl_no_as400='5965645')
[INFO] === 2010-12-06 11:38:55,116 [l0-2] INFO  DSResponse - [builtinApplication.ficheClientDs_fetch] DSResponse: List with 1 items
[INFO] === 2010-12-06 11:38:55,119 [l0-2] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
[INFO] === 2010-12-06 11:38:55,120 [l0-2] DEBUG RPCManager - non-DMI response, dropExtraFields: false
[INFO] === 2010-12-06 11:38:55,146 [l0-0] INFO  RequestContext - URL: '/csmpapp/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows; U; Windows NT 6.0; en-US) AppleWebKit/534.12 (KHTML, like Gecko) Chrome/9.0.587.0 Safari/534.12': Safari with Accept-Encoding header
[INFO] === 2010-12-06 11:38:55,165 [l0-0] DEBUG XML - Parsed XML from (in memory stream): 8ms
[INFO] === 2010-12-06 11:38:55,176 [l0-0] DEBUG RPCManager - Processing 1 requests.
[INFO] === 2010-12-06 11:38:55,182 [l0-0] DEBUG RPCManager - Request #1 (DSRequest) payload: {
[INFO]     criteria:{
[INFO]     },
[INFO]     operationConfig:{
[INFO]         dataSource:"user",
[INFO]         operationType:"fetch",
[INFO]         textMatchStyle:"exact"
[INFO]     },
[INFO]     startRow:0,
[INFO]     endRow:75,
[INFO]     componentId:"isc_ListGrid_1",
[INFO]     appID:"builtinApplication",
[INFO]     operation:"user_fetch",
[INFO]     oldValues:{
[ERROR] 2010-12-06 11:38:55 com.cogeco.csmp.gwt.server.datasource.UserDmi fetch
[ERROR] INFO: UserDmi.fetch = t_csmp_RO (R--)
[ERROR] 2010-12-06 11:38:55 com.cogeco.csmp.gwt.server.datasource.UserDmi fetch
[ERROR] INFO: UserDmi.fetch completed
[INFO]     }
[INFO] }
[INFO] === 2010-12-06 11:38:55,183 [l0-0] INFO  IDACall - Performing 1 operation(s)
[INFO] === 2010-12-06 11:38:55,222 [l0-0] INFO  DSResponse - DSResponse: List with 1 items
[INFO] === 2010-12-06 11:38:55,232 [l0-0] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
[INFO] === 2010-12-06 11:38:55,233 [l0-0] DEBUG RPCManager - DMI response, dropExtraFields: true