Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001738/0.001738, allocations: 112.7 kB / 18.34 MB, free: 3.961 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00171/0.00171, allocations: 190 kB / 21.52 MB, free: 0.7969 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.441/1.441, allocations: 225.6 MB / 250.1 MB, free: 13.52 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 3.074/3.074, allocations: 496.1 MB / 0.7826 GB, free: 33.68 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|cooTowSpeCon.TCHWSupSet|cooTowSpeCon.TCWSupSet|cooTowSpeCon.TCHWSup|cooTowSpeCon.TCWSup|cooTowSpeCon.cooMod|cooTowSpeCon.y",fileNamePrefix="Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed")
translateModel(Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|cooTowSpeCon.TCHWSupSet|cooTowSpeCon.TCWSupSet|cooTowSpeCon.TCHWSup|cooTowSpeCon.TCWSup|cooTowSpeCon.cooMod|cooTowSpeCon.y",fileNamePrefix="Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.242e-05/2.242e-05, allocations: 5.453 kB / 1.136 GB, free: 33.77 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed): time 0.003638/0.00366, allocations: 2.963 MB / 1.139 GB, free: 31.71 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.002088/0.005748, allocations: 1.54 MB / 1.141 GB, free: 30.64 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002256/0.005974, allocations: 14.03 kB / 1.141 GB, free: 30.64 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 0.0003994/0.006373, allocations: 97.28 kB / 1.141 GB, free: 30.58 MB / 0.9044 GB
Notification: Performance of NFTyping.typeBindings: time 0.0003276/0.006701, allocations: 146 kB / 1.141 GB, free: 30.49 MB / 0.9044 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0007888/0.00749, allocations: 417.9 kB / 1.142 GB, free: 30.26 MB / 0.9044 GB
Notification: Performance of NFFlatten.flatten: time 0.0005117/0.008002, allocations: 0.6409 MB / 1.142 GB, free: 29.94 MB / 0.9044 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00023/0.008231, allocations: 136.8 kB / 1.142 GB, free: 29.86 MB / 0.9044 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0002816/0.008513, allocations: 265.9 kB / 1.143 GB, free: 29.72 MB / 0.9044 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001934/0.008707, allocations: 199.5 kB / 1.143 GB, free: 29.61 MB / 0.9044 GB
Notification: Performance of NFPackage.collectConstants: time 5.945e-05/0.008766, allocations: 38.91 kB / 1.143 GB, free: 29.61 MB / 0.9044 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001732/0.008939, allocations: 98.05 kB / 1.143 GB, free: 29.6 MB / 0.9044 GB
Notification: Performance of combineBinaries: time 0.0003847/0.009324, allocations: 0.7462 MB / 1.144 GB, free: 29.06 MB / 0.9044 GB
Notification: Performance of replaceArrayConstructors: time 0.0001964/0.00952, allocations: 470 kB / 1.144 GB, free: 28.73 MB / 0.9044 GB
Notification: Performance of NFVerifyModel.verify: time 7.491e-05/0.009595, allocations: 77.69 kB / 1.144 GB, free: 28.68 MB / 0.9044 GB
Notification: Performance of FrontEnd: time 0.0001069/0.009702, allocations: 28.94 kB / 1.144 GB, free: 28.66 MB / 0.9044 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 65 (65)
 * Number of variables: 65 (65)
Notification: Performance of Bindings: time 0.001335/0.01104, allocations: 1.551 MB / 1.146 GB, free: 27.46 MB / 0.9044 GB
Notification: Performance of FunctionAlias: time 0.000195/0.01123, allocations: 180.7 kB / 1.146 GB, free: 27.35 MB / 0.9044 GB
Notification: Performance of Early Inline: time 0.000526/0.01176, allocations: 0.5717 MB / 1.146 GB, free: 26.96 MB / 0.9044 GB
Notification: Performance of Simplify 1: time 0.0001427/0.0119, allocations: 133.4 kB / 1.147 GB, free: 26.86 MB / 0.9044 GB
Notification: Performance of Alias: time 0.001837/0.01374, allocations: 1.48 MB / 1.148 GB, free: 25.87 MB / 0.9044 GB
Notification: Performance of Simplify 2: time 9.463e-05/0.01383, allocations: 92.22 kB / 1.148 GB, free: 25.79 MB / 0.9044 GB
Notification: Performance of Remove Stream: time 7.124e-05/0.0139, allocations: 92.05 kB / 1.148 GB, free: 25.71 MB / 0.9044 GB
Notification: Performance of Detect States: time 0.0003563/0.01426, allocations: 187.5 kB / 1.148 GB, free: 25.54 MB / 0.9044 GB
Notification: Performance of Events: time 0.0001631/0.01442, allocations: 132.5 kB / 1.148 GB, free: 25.46 MB / 0.9044 GB
Notification: Performance of Partitioning: time 0.0002564/0.01468, allocations: 265.1 kB / 1.149 GB, free: 25.28 MB / 0.9044 GB
Notification: Performance of Causalize: time 0.001017/0.0157, allocations: 0.8403 MB / 1.15 GB, free: 24.96 MB / 0.9044 GB
Notification: Performance of After Index Reduction Inline: time 0.000318/0.01601, allocations: 373 kB / 1.15 GB, free: 24.74 MB / 0.9044 GB
Notification: Performance of Simplify: time 0.002182/0.0182, allocations: 0.5975 MB / 1.15 GB, free: 24.36 MB / 0.9044 GB
Notification: Performance of Inline: time 0.0005435/0.01874, allocations: 0.5973 MB / 1.151 GB, free: 24 MB / 0.9044 GB
Notification: Performance of Partitioning: time 4.853e-05/0.01879, allocations: 37.38 kB / 1.151 GB, free: 23.96 MB / 0.9044 GB
Notification: Performance of Cleanup: time 0.0001127/0.0189, allocations: 167.3 kB / 1.151 GB, free: 23.86 MB / 0.9044 GB
Notification: Performance of Causalize: time 0.001941/0.02084, allocations: 1.475 MB / 1.153 GB, free: 23.37 MB / 0.9044 GB
Notification: Performance of Tearing: time 1.337e-05/0.02086, allocations: 1.125 kB / 1.153 GB, free: 23.37 MB / 0.9044 GB
Notification: Performance of Initialization: time 3.11e-07/0.02086, allocations: 0 / 1.153 GB, free: 23.37 MB / 0.9044 GB
Notification: Performance of Remove Dummies: time 9.238e-06/0.02087, allocations: 1.969 kB / 1.153 GB, free: 23.37 MB / 0.9044 GB
Notification: Performance of Tearing: time 3.937e-06/0.02087, allocations: 1.062 kB / 1.153 GB, free: 23.37 MB / 0.9044 GB
Notification: Performance of Categorize: time 1.497e-05/0.02088, allocations: 6.25 kB / 1.153 GB, free: 23.36 MB / 0.9044 GB
Notification: Performance of Solve: time 0.0002759/0.02116, allocations: 152.6 kB / 1.153 GB, free: 23.31 MB / 0.9044 GB
Notification: Performance of Jacobian: time 0.0003436/0.0215, allocations: 387.3 kB / 1.153 GB, free: 23 MB / 0.9044 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 3
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 1 (1) {cooTowSpeCon.conPID.I.y}
 * Number of discrete states: .................... 2 (2) {cooMod.combiTimeTable.nextTimeEvent, cooMod.combiTimeTable.nextTimeEventScaled}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 15 (15) {cooTowSpeCon.pmcMod.y, cooTowSpeCon.cooMod, cooTowSpeCon.swi2.u2, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_2, $TEV_1, $TEV_0}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 37 (scalar:37, array:0, record:0)
 * Number of multi strong components: ............ 2 (algorithm:0, when:2, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 68 (scalar:66, array:1, record:1)
 * Number of multi strong components: ............ 2 (algorithm:2, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 4.646e-05/0.02155, allocations: 50.8 kB / 1.153 GB, free: 22.96 MB / 0.9044 GB
Notification: Performance of SimCode: time 0.003484/0.02503, allocations: 2.412 MB / 1.156 GB, free: 21.55 MB / 0.9044 GB
Notification: Performance of Templates: time 0.009296/0.03433, allocations: 3.591 MB / 1.159 GB, free: 21.24 MB / 0.9044 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed.pipe ; mkfifo Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed.pipe ; head -c 1048576 < Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed.pipe >> ../files/Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed.sim & ./Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Applications_DataCenters_ChillerCooled_Controls_Validation_CoolingTowerSpeed.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Applications.DataCenters.ChillerCooled.Controls.Validation.CoolingTowerSpeed.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
""

Variables in the reference:time,cooTowSpeCon.TCHWSupSet,cooTowSpeCon.TCWSupSet,cooTowSpeCon.TCHWSup,cooTowSpeCon.TCWSup,cooTowSpeCon.cooMod,cooTowSpeCon.y

Variables in the result:CHWST.amplitude,CHWST.f,CHWST.offset,CHWST.phase,CHWST.startTime,CHWST.y,CHWSTSet.k,CHWSTSet.y,CWST.amplitude,CWST.f,CWST.offset,CWST.phase,CWST.startTime,CWST.y,CWSTSet.k,CWSTSet.y,cooMod.combiTimeTable.columns[1],cooMod.combiTimeTable.extrapolation,cooMod.combiTimeTable.nout,cooMod.combiTimeTable.offset[1],cooMod.combiTimeTable.p_offset[1],cooMod.combiTimeTable.shiftTime,cooMod.combiTimeTable.smoothness,cooMod.combiTimeTable.startTime,cooMod.combiTimeTable.t_max,cooMod.combiTimeTable.t_maxScaled,cooMod.combiTimeTable.t_min,cooMod.combiTimeTable.t_minScaled,cooMod.combiTimeTable.tableOnFile,cooMod.combiTimeTable.table[1,1],cooMod.combiTimeTable.table[1,2],cooMod.combiTimeTable.table[2,1],cooMod.combiTimeTable.table[2,2],cooMod.combiTimeTable.table[3,1],cooMod.combiTimeTable.table[3,2],cooMod.combiTimeTable.timeEvents,cooMod.combiTimeTable.timeScale,cooMod.combiTimeTable.timeScaled,cooMod.combiTimeTable.verboseExtrapolation,cooMod.combiTimeTable.verboseRead,cooMod.extrapolation,cooMod.n,cooMod.shiftTime,cooMod.startTime,cooMod.table[1,1],cooMod.table[1,2],cooMod.table[2,1],cooMod.table[2,2],cooMod.table[3,1],cooMod.table[3,2],cooTowSpeCon.TCHWSup,cooTowSpeCon.TCHWSupSet,cooTowSpeCon.TCWSup,cooTowSpeCon.TCWSupSet,cooTowSpeCon.Td,cooTowSpeCon.Ti,cooTowSpeCon.conPID.I.initType,cooTowSpeCon.conPID.I.k,cooTowSpeCon.conPID.I.reset,cooTowSpeCon.conPID.I.trigger_internal,cooTowSpeCon.conPID.I.y_reset,cooTowSpeCon.conPID.I.y_reset_internal,cooTowSpeCon.conPID.I.y_start,cooTowSpeCon.conPID.Nd,cooTowSpeCon.conPID.Ni,cooTowSpeCon.conPID.P.k,cooTowSpeCon.conPID.Td,cooTowSpeCon.conPID.Ti,cooTowSpeCon.conPID.addI.k1,cooTowSpeCon.conPID.addI.k2,cooTowSpeCon.conPID.addI.k3,cooTowSpeCon.conPID.addP.k1,cooTowSpeCon.conPID.addP.k2,cooTowSpeCon.conPID.addPID.k1,cooTowSpeCon.conPID.addPID.k2,cooTowSpeCon.conPID.addPID.k3,cooTowSpeCon.conPID.addPID.u2,cooTowSpeCon.conPID.addSat.k1,cooTowSpeCon.conPID.addSat.k2,cooTowSpeCon.conPID.controllerType,cooTowSpeCon.conPID.gainPID.k,cooTowSpeCon.conPID.gainTrack.k,cooTowSpeCon.conPID.initType,cooTowSpeCon.conPID.k,cooTowSpeCon.conPID.limiter.limitsAtInit,cooTowSpeCon.conPID.limiter.strict,cooTowSpeCon.conPID.limiter.uMax,cooTowSpeCon.conPID.limiter.uMin,cooTowSpeCon.conPID.reset,cooTowSpeCon.conPID.revAct,cooTowSpeCon.conPID.reverseActing,cooTowSpeCon.conPID.strict,cooTowSpeCon.conPID.wd,cooTowSpeCon.conPID.wp,cooTowSpeCon.conPID.xd_start,cooTowSpeCon.conPID.xi_start,cooTowSpeCon.conPID.yMax,cooTowSpeCon.conPID.yMin,cooTowSpeCon.conPID.y_reset,cooTowSpeCon.conPID.y_reset_internal,cooTowSpeCon.conPID.y_start,cooTowSpeCon.controllerType,cooTowSpeCon.cooMod,cooTowSpeCon.fmcMod.threshold,cooTowSpeCon.k,cooTowSpeCon.reverseActing,cooTowSpeCon.swi1.u1,cooTowSpeCon.swi1.u3,cooTowSpeCon.swi3.u1,cooTowSpeCon.uni.k,cooTowSpeCon.uni.y,cooTowSpeCon.y,cooTowSpeCon.yMax,cooTowSpeCon.yMin,time
[Calling sys.exit(0), Time elapsed: 8.48975396156311]