2025/05/03 11:39:57 - Kitchen - Logging is at level : Detailed logging
2025/05/03 11:39:57 - Kitchen - Start of run.
2025/05/03 11:39:57 - CargaArchivos - Start of job execution
2025/05/03 11:39:57 - CargaArchivos - exec(0, 0, START.0)
2025/05/03 11:39:57 - START - Starting job entry
2025/05/03 11:39:57 - CargaArchivos - Starting entry [Es GPL?]
2025/05/03 11:39:57 - CargaArchivos - exec(1, 0, Es GPL?.0)
2025/05/03 11:39:57 - Es GPL? - Starting job entry
2025/05/03 11:39:57 - Es GPL? - Value to evaluate is WPL
2025/05/03 11:39:57 - CargaArchivos - Starting entry [Es WPL?]
2025/05/03 11:39:57 - CargaArchivos - exec(2, 0, Es WPL?.0)
2025/05/03 11:39:57 - Es GPL? - Starting job entry
2025/05/03 11:39:57 - Es GPL? - Value to evaluate is WPL
2025/05/03 11:39:57 - CargaArchivos - Starting entry [Drop Index y Vacia Tablas WPL]
2025/05/03 11:39:57 - CargaArchivos - exec(3, 0, Drop Index y Vacia Tablas WPL.0)
2025/05/03 11:39:57 - Es GPL? - Starting job entry
2025/05/03 11:39:57 - localPostgre - New database connection defined
2025/05/03 11:39:57 - localPostgre - Connected to database.
2025/05/03 11:39:57 - Es GPL? - Running SQL :DROP INDEX IF EXISTS partnumberwpl_idx;
2025/05/03 11:39:57 - Es GPL? - TRUNCATE TABLE wholesale_price_list_tmp;
2025/05/03 11:39:57 - Es GPL? - update tipo_dato set validado = false, ingresado = true,
2025/05/03 11:39:57 - Es GPL? - observacion = 'A la espera de valicación de datos' where nombre = 'WPL';
2025/05/03 11:39:57 - localPostgre - launch DDL statement: 
2025/05/03 11:39:57 - localPostgre - DROP INDEX IF EXISTS partnumberwpl_idx
2025/05/03 11:39:57 - localPostgre - launch DDL statement: 
2025/05/03 11:39:57 - localPostgre - TRUNCATE TABLE wholesale_price_list_tmp
2025/05/03 11:39:57 - localPostgre - launch DDL statement: 
2025/05/03 11:39:57 - localPostgre - update tipo_dato set validado = false, ingresado = true,
2025/05/03 11:39:57 - localPostgre - observacion = 'A la espera de valicación de datos' where nombre = 'WPL'
2025/05/03 11:39:57 - localPostgre - 3 statements executed
2025/05/03 11:39:57 - localPostgre - Connection to database closed!
2025/05/03 11:39:57 - CargaArchivos - Starting entry [CargaWPL]
2025/05/03 11:39:57 - CargaArchivos - exec(4, 0, CargaWPL.0)
2025/05/03 11:39:57 - CargaWPL - Starting job entry
2025/05/03 11:39:57 - CargaWPL - Opening transformation: [file:///home/admin_tecno/transformaciones/LecturaWPL.ktr]
2025/05/03 11:39:57 - CargaWPL - Loading transformation from XML file [file:///home/admin_tecno/transformaciones/LecturaWPL.ktr]
2025/05/03 11:39:58 - CargaWPL - Starting transformation...(file=${Internal.Job.Filename.Directory}/LecturaWPL.ktr, name=CargaWPL, repinfo=null)
2025/05/03 11:39:58 - LecturaWPL - Transformation is pre-loaded.
2025/05/03 11:39:58 - LecturaWPL - Dispatching started for transformation [LecturaWPL]
2025/05/03 11:39:58 - LecturaWPL - Nr of arguments detected:0 
2025/05/03 11:39:58 - LecturaWPL - This is not a replay transformation
2025/05/03 11:39:58 - LecturaWPL - I found 7 different steps to launch.
2025/05/03 11:39:58 - LecturaWPL - Allocating rowsets...
2025/05/03 11:39:58 - LecturaWPL -  Allocating rowsets for step 0 --> Text file input
2025/05/03 11:39:58 - LecturaWPL -   prevcopies = 1, nextcopies=1
2025/05/03 11:39:58 - LecturaWPL - Transformation allocated new rowset [Text file input.0 - Modified Java Script Value 2.0]
2025/05/03 11:39:58 - LecturaWPL -  Allocated 1 rowsets for step 0 --> Text file input  
2025/05/03 11:39:58 - LecturaWPL -  Allocating rowsets for step 1 --> Modified Java Script Value 2
2025/05/03 11:39:58 - LecturaWPL -   prevcopies = 1, nextcopies=1
2025/05/03 11:39:58 - LecturaWPL - Transformation allocated new rowset [Modified Java Script Value 2.0 - Filter rows 2.0]
2025/05/03 11:39:58 - LecturaWPL -  Allocated 2 rowsets for step 1 --> Modified Java Script Value 2  
2025/05/03 11:39:58 - LecturaWPL -  Allocating rowsets for step 2 --> Filter rows
2025/05/03 11:39:58 - LecturaWPL -   prevcopies = 1, nextcopies=1
2025/05/03 11:39:58 - LecturaWPL - Transformation allocated new rowset [Filter rows.0 - Table output.0]
2025/05/03 11:39:58 - LecturaWPL -   prevcopies = 1, nextcopies=1
2025/05/03 11:39:58 - LecturaWPL - Transformation allocated new rowset [Filter rows.0 - Dummy (do nothing).0]
2025/05/03 11:39:58 - LecturaWPL -  Allocated 4 rowsets for step 2 --> Filter rows  
2025/05/03 11:39:58 - LecturaWPL -  Allocating rowsets for step 3 --> Table output
2025/05/03 11:39:58 - LecturaWPL -  Allocated 4 rowsets for step 3 --> Table output  
2025/05/03 11:39:58 - LecturaWPL -  Allocating rowsets for step 4 --> Dummy (do nothing)
2025/05/03 11:39:58 - LecturaWPL -  Allocated 4 rowsets for step 4 --> Dummy (do nothing)  
2025/05/03 11:39:58 - LecturaWPL -  Allocating rowsets for step 5 --> Filter rows 2
2025/05/03 11:39:58 - LecturaWPL -   prevcopies = 1, nextcopies=1
2025/05/03 11:39:58 - LecturaWPL - Transformation allocated new rowset [Filter rows 2.0 - Filter rows.0]
2025/05/03 11:39:58 - LecturaWPL -   prevcopies = 1, nextcopies=1
2025/05/03 11:39:58 - LecturaWPL - Transformation allocated new rowset [Filter rows 2.0 - Abort.0]
2025/05/03 11:39:58 - LecturaWPL -  Allocated 6 rowsets for step 5 --> Filter rows 2  
2025/05/03 11:39:58 - LecturaWPL -  Allocating rowsets for step 6 --> Abort
2025/05/03 11:39:58 - LecturaWPL -  Allocated 6 rowsets for step 6 --> Abort  
2025/05/03 11:39:58 - LecturaWPL - Allocating Steps & StepData...
2025/05/03 11:39:58 - LecturaWPL -  Transformation is about to allocate step [Text file input] of type [TextFileInput]
2025/05/03 11:39:58 - Text file input.0 - Starting allocation of buffers & new threads...
2025/05/03 11:39:58 - Text file input.0 - Step info: nrinput=0 nroutput=1
2025/05/03 11:39:58 - Text file input.0 - output rel. is  1:1
2025/05/03 11:39:58 - Text file input.0 - Found output rowset [Text file input.0 - Modified Java Script Value 2.0]
2025/05/03 11:39:58 - Text file input.0 - Finished dispatching
2025/05/03 11:39:58 - LecturaWPL -  Transformation has allocated a new step: [Text file input].0
2025/05/03 11:39:58 - LecturaWPL -  Transformation is about to allocate step [Modified Java Script Value 2] of type [ScriptValueMod]
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - distribution activated
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - Starting allocation of buffers & new threads...
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - Step info: nrinput=1 nroutput=1
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - Got previous step from [Modified Java Script Value 2] #0 --> Text file input
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - input rel is 1:1
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - Found input rowset [Text file input.0 - Modified Java Script Value 2.0]
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - output rel. is  1:1
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - Found output rowset [Modified Java Script Value 2.0 - Filter rows 2.0]
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - Finished dispatching
2025/05/03 11:39:58 - LecturaWPL -  Transformation has allocated a new step: [Modified Java Script Value 2].0
2025/05/03 11:39:58 - LecturaWPL -  Transformation is about to allocate step [Filter rows] of type [FilterRows]
2025/05/03 11:39:58 - Filter rows.0 - distribution activated
2025/05/03 11:39:58 - Filter rows.0 - Starting allocation of buffers & new threads...
2025/05/03 11:39:58 - Filter rows.0 - Step info: nrinput=1 nroutput=2
2025/05/03 11:39:58 - Filter rows.0 - Got previous step from [Filter rows] #0 --> Filter rows 2
2025/05/03 11:39:58 - Filter rows.0 - input rel is 1:1
2025/05/03 11:39:58 - Filter rows.0 - Found input rowset [Filter rows 2.0 - Filter rows.0]
2025/05/03 11:39:58 - Filter rows.0 - output rel. is  1:1
2025/05/03 11:39:58 - Filter rows.0 - Found output rowset [Filter rows.0 - Table output.0]
2025/05/03 11:39:58 - Filter rows.0 - output rel. is  1:1
2025/05/03 11:39:58 - Filter rows.0 - Found output rowset [Filter rows.0 - Dummy (do nothing).0]
2025/05/03 11:39:58 - Filter rows.0 - Finished dispatching
2025/05/03 11:39:58 - LecturaWPL -  Transformation has allocated a new step: [Filter rows].0
2025/05/03 11:39:58 - LecturaWPL -  Transformation is about to allocate step [Table output] of type [TableOutput]
2025/05/03 11:39:58 - Table output.0 - distribution activated
2025/05/03 11:39:58 - Table output.0 - Starting allocation of buffers & new threads...
2025/05/03 11:39:58 - Table output.0 - Step info: nrinput=1 nroutput=0
2025/05/03 11:39:58 - Table output.0 - Got previous step from [Table output] #0 --> Filter rows
2025/05/03 11:39:58 - Table output.0 - input rel is 1:1
2025/05/03 11:39:58 - Table output.0 - Found input rowset [Filter rows.0 - Table output.0]
2025/05/03 11:39:58 - Table output.0 - Finished dispatching
2025/05/03 11:39:58 - LecturaWPL -  Transformation has allocated a new step: [Table output].0
2025/05/03 11:39:58 - LecturaWPL -  Transformation is about to allocate step [Dummy (do nothing)] of type [Dummy]
2025/05/03 11:39:58 - Dummy (do nothing).0 - distribution activated
2025/05/03 11:39:58 - Dummy (do nothing).0 - Starting allocation of buffers & new threads...
2025/05/03 11:39:58 - Dummy (do nothing).0 - Step info: nrinput=1 nroutput=0
2025/05/03 11:39:58 - Dummy (do nothing).0 - Got previous step from [Dummy (do nothing)] #0 --> Filter rows
2025/05/03 11:39:58 - Dummy (do nothing).0 - input rel is 1:1
2025/05/03 11:39:58 - Dummy (do nothing).0 - Found input rowset [Filter rows.0 - Dummy (do nothing).0]
2025/05/03 11:39:58 - Dummy (do nothing).0 - Finished dispatching
2025/05/03 11:39:58 - LecturaWPL -  Transformation has allocated a new step: [Dummy (do nothing)].0
2025/05/03 11:39:58 - LecturaWPL -  Transformation is about to allocate step [Filter rows 2] of type [FilterRows]
2025/05/03 11:39:58 - Filter rows 2.0 - distribution activated
2025/05/03 11:39:58 - Filter rows 2.0 - Starting allocation of buffers & new threads...
2025/05/03 11:39:58 - Filter rows 2.0 - Step info: nrinput=1 nroutput=2
2025/05/03 11:39:58 - Filter rows 2.0 - Got previous step from [Filter rows 2] #0 --> Modified Java Script Value 2
2025/05/03 11:39:58 - Filter rows 2.0 - input rel is 1:1
2025/05/03 11:39:58 - Filter rows 2.0 - Found input rowset [Modified Java Script Value 2.0 - Filter rows 2.0]
2025/05/03 11:39:58 - Filter rows 2.0 - output rel. is  1:1
2025/05/03 11:39:58 - Filter rows 2.0 - Found output rowset [Filter rows 2.0 - Filter rows.0]
2025/05/03 11:39:58 - Filter rows 2.0 - output rel. is  1:1
2025/05/03 11:39:58 - Filter rows 2.0 - Found output rowset [Filter rows 2.0 - Abort.0]
2025/05/03 11:39:58 - Filter rows 2.0 - Finished dispatching
2025/05/03 11:39:58 - LecturaWPL -  Transformation has allocated a new step: [Filter rows 2].0
2025/05/03 11:39:58 - LecturaWPL -  Transformation is about to allocate step [Abort] of type [Abort]
2025/05/03 11:39:58 - Abort.0 - distribution activated
2025/05/03 11:39:58 - Abort.0 - Starting allocation of buffers & new threads...
2025/05/03 11:39:58 - Abort.0 - Step info: nrinput=1 nroutput=0
2025/05/03 11:39:58 - Abort.0 - Got previous step from [Abort] #0 --> Filter rows 2
2025/05/03 11:39:58 - Abort.0 - input rel is 1:1
2025/05/03 11:39:58 - Abort.0 - Found input rowset [Filter rows 2.0 - Abort.0]
2025/05/03 11:39:58 - Abort.0 - Finished dispatching
2025/05/03 11:39:58 - LecturaWPL -  Transformation has allocated a new step: [Abort].0
2025/05/03 11:39:58 - LecturaWPL - This transformation can be replayed with replay date: 2025/05/03 11:39:58
2025/05/03 11:39:58 - LecturaWPL - Initialising 7 steps...
2025/05/03 11:39:58 - Text file input.0 - Running on slave server #0/1.
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - Running on slave server #0/1.
2025/05/03 11:39:58 - Filter rows.0 - Running on slave server #0/1.
2025/05/03 11:39:58 - Table output.0 - Running on slave server #0/1.
2025/05/03 11:39:58 - Dummy (do nothing).0 - Running on slave server #0/1.
2025/05/03 11:39:58 - Filter rows 2.0 - Running on slave server #0/1.
2025/05/03 11:39:58 - localPostGres - New database connection defined
2025/05/03 11:39:58 - Abort.0 - Running on slave server #0/1.
2025/05/03 11:39:58 - localPostGres - Connected to database.
2025/05/03 11:39:58 - Table output.0 - Connected to database [localPostGres] (commit=1000)
2025/05/03 11:39:58 - localPostGres - Auto commit off
2025/05/03 11:39:58 - LecturaWPL - Step [Text file input.0] initialized flawlessly.
2025/05/03 11:39:58 - LecturaWPL - Step [Modified Java Script Value 2.0] initialized flawlessly.
2025/05/03 11:39:58 - LecturaWPL - Step [Filter rows.0] initialized flawlessly.
2025/05/03 11:39:58 - LecturaWPL - Step [Table output.0] initialized flawlessly.
2025/05/03 11:39:58 - LecturaWPL - Step [Dummy (do nothing).0] initialized flawlessly.
2025/05/03 11:39:58 - LecturaWPL - Step [Filter rows 2.0] initialized flawlessly.
2025/05/03 11:39:58 - LecturaWPL - Step [Abort.0] initialized flawlessly.
2025/05/03 11:39:58 - Text file input.0 - Starting to run...
2025/05/03 11:39:58 - Text file input.0 - Opening file: file:///var/www/informes/datos/wpl/wic2.web
2025/05/03 11:39:58 - Filter rows.0 - Starting to run...
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - Starting to run...
2025/05/03 11:39:58 - Table output.0 - Starting to run...
2025/05/03 11:39:58 - Dummy (do nothing).0 - Starting to run...
2025/05/03 11:39:58 - Abort.0 - Starting to run...
2025/05/03 11:39:58 - Modified Java Script Value 2.0 - Finished processing (I=0, O=0, R=0, W=0, U=0, E=0)
2025/05/03 11:39:58 - Text file input.0 - Finished processing (I=0, O=0, R=0, W=0, U=1, E=0)
2025/05/03 11:39:58 - LecturaWPL - Transformation has allocated 7 threads and 6 rowsets.
2025/05/03 11:39:58 - Filter rows 2.0 - Starting to run...
2025/05/03 11:39:58 - Filter rows 2.0 - Finished processing (I=0, O=0, R=0, W=0, U=0, E=0)
2025/05/03 11:39:58 - Filter rows.0 - Finished processing (I=0, O=0, R=0, W=0, U=0, E=0)
2025/05/03 11:39:58 - Abort.0 - Finished processing (I=0, O=0, R=0, W=0, U=0, E=0)
2025/05/03 11:39:58 - Dummy (do nothing).0 - Finished processing (I=0, O=0, R=0, W=0, U=0, E=0)
2025/05/03 11:39:58 - localPostGres - Connection to database closed!
2025/05/03 11:39:58 - Table output.0 - Finished processing (I=0, O=0, R=0, W=0, U=0, E=0)
2025/05/03 11:39:58 - CargaArchivos - Starting entry [Existen datos ? WPL]
2025/05/03 11:39:58 - CargaArchivos - exec(5, 0, Existen datos ? WPL.0)
2025/05/03 11:39:58 - Es GPL? - Starting job entry
2025/05/03 11:39:58 - Es GPL? - Rows limit set to [1]
2025/05/03 11:39:58 - localPostgre - New database connection defined
2025/05/03 11:39:58 - localPostgre - Connected to database.
2025/05/03 11:39:58 - Es GPL? - We will run the following SQL statement : SELECT 1 as valor
2025/05/03 11:39:58 - Es GPL? - UNION
2025/05/03 11:39:58 - Es GPL? - SELECT 2 as valor
2025/05/03 11:39:58 - Es GPL? - FROM
2025/05/03 11:39:58 - Es GPL? - (
2025/05/03 11:39:58 - Es GPL? - SELECT partnumber_wpl, descripcion_wpl , preciousd_wpl
2025/05/03 11:39:58 - Es GPL? - from wholesale_price_list_tmp
2025/05/03 11:39:58 - Es GPL? - WHERE UPPER(partnumber_wpl) NOT LIKE 'CON-%'
2025/05/03 11:39:58 - Es GPL? - group by partnumber_wpl, descripcion_wpl , preciousd_wpl
2025/05/03 11:39:58 - Es GPL? - ) b
2025/05/03 11:39:58 - Es GPL? - We returned 1 row(s)
2025/05/03 11:39:58 - localPostgre - Connection to database closed!
2025/05/03 11:39:58 - CargaArchivos - Starting entry [No existen datos WPL a cargar]
2025/05/03 11:39:58 - CargaArchivos - exec(6, 0, No existen datos WPL a cargar.0)
2025/05/03 11:39:58 - Es GPL? - Starting job entry
2025/05/03 11:39:58 - localPostgre - New database connection defined
2025/05/03 11:39:58 - localPostgre - Connected to database.
2025/05/03 11:39:58 - Es GPL? - Running SQL :update tipo_dato set validado = false, ingresado = false,
2025/05/03 11:39:58 - Es GPL? - observacion = 'No existen datos a cargar, favor revise los datos' where lower(nombre) = 'wpl';
2025/05/03 11:39:58 - localPostgre - launch DDL statement: 
2025/05/03 11:39:58 - localPostgre - update tipo_dato set validado = false, ingresado = false,
2025/05/03 11:39:58 - localPostgre - observacion = 'No existen datos a cargar, favor revise los datos' where lower(nombre) = 'wpl'
2025/05/03 11:39:58 - localPostgre - 1 statement executed
2025/05/03 11:39:58 - localPostgre - Connection to database closed!
2025/05/03 11:39:58 - CargaArchivos - Finished job entry [No existen datos WPL a cargar] (result=[true])
2025/05/03 11:39:58 - CargaArchivos - Finished job entry [Existen datos ? WPL] (result=[true])
2025/05/03 11:39:58 - CargaArchivos - Finished job entry [CargaWPL] (result=[true])
2025/05/03 11:39:58 - CargaArchivos - Finished job entry [Drop Index y Vacia Tablas WPL] (result=[true])
2025/05/03 11:39:58 - CargaArchivos - Finished job entry [Es WPL?] (result=[true])
2025/05/03 11:39:58 - CargaArchivos - Finished job entry [Es GPL?] (result=[true])
2025/05/03 11:39:58 - CargaArchivos - Job execution finished