Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo", uses=false)
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.Fluid.Movers.Examples.ClosedLoop_y,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|conPID.u_s|conPID.u_m|conPID.y",fileNamePrefix="Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y")
translateModel(Buildings.Fluid.Movers.Examples.ClosedLoop_y,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|conPID.u_s|conPID.u_m|conPID.y",fileNamePrefix="Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001584/0.001583, allocations: 111.8 kB / 16.42 MB, free: 5.918 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001836/0.001836, allocations: 191.7 kB / 17.35 MB, free: 5.555 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.339/1.339, allocations: 222.9 MB / 241.1 MB, free: 15.09 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.638/2.638, allocations: 472.7 MB / 0.746 GB, free: 0.4922 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001377/0.001377, allocations: 67.88 kB / 1.07 GB, free: 9.578 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7238/0.7252, allocations: 159.9 MB / 1.226 GB, free: 13.49 MB / 0.9512 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Movers.Examples.ClosedLoop_y): time 0.2056/0.9309, allocations: 206.1 MB / 1.428 GB, free: 14.67 MB / 1.154 GB
Notification: Performance of NFInst.instExpressions: time 0.0209/0.9518, allocations: 15.39 MB / 1.443 GB, free: 15.23 MB / 1.17 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001923/0.9538, allocations: 55.69 kB / 1.443 GB, free: 15.18 MB / 1.17 GB
Notification: Performance of NFTyping.typeComponents: time 0.004817/0.9586, allocations: 1.758 MB / 1.444 GB, free: 13.41 MB / 1.17 GB
Notification: Performance of NFTyping.typeBindings: time 0.006503/0.9652, allocations: 2.726 MB / 1.447 GB, free: 10.68 MB / 1.17 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00409/0.9693, allocations: 1.62 MB / 1.449 GB, free: 9.066 MB / 1.17 GB
Notification: Performance of NFFlatten.flatten: time 0.0132/0.9825, allocations: 9.162 MB / 1.458 GB, free: 15.88 MB / 1.186 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002445/0.9849, allocations: 1.425 MB / 1.459 GB, free: 14.42 MB / 1.186 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00458/0.9895, allocations: 2.117 MB / 1.461 GB, free: 12.29 MB / 1.186 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002561/0.9921, allocations: 1.25 MB / 1.462 GB, free: 11.04 MB / 1.186 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005321/0.9927, allocations: 176 kB / 1.462 GB, free: 10.87 MB / 1.186 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005302/0.998, allocations: 2.725 MB / 1.465 GB, free: 8.137 MB / 1.186 GB
Notification: Performance of NFScalarize.scalarize: time 0.0009522/0.999, allocations: 0.7323 MB / 1.466 GB, free: 7.402 MB / 1.186 GB
Notification: Performance of NFVerifyModel.verify: time 0.001783/1.001, allocations: 1.088 MB / 1.467 GB, free: 6.309 MB / 1.186 GB
Notification: Performance of NFConvertDAE.convert: time 0.006704/1.007, allocations: 3.932 MB / 1.471 GB, free: 2.363 MB / 1.186 GB
Notification: Performance of FrontEnd - DAE generated: time 3.918e-06/1.007, allocations: 0 / 1.471 GB, free: 2.363 MB / 1.186 GB
Notification: Performance of FrontEnd: time 1.503e-06/1.007, allocations: 0 / 1.471 GB, free: 2.363 MB / 1.186 GB
Notification: Performance of Transformations before backend: time 8.959e-05/1.008, allocations: 0 / 1.471 GB, free: 2.363 MB / 1.186 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 244
 * Number of variables: 244
Notification: Performance of Generate backend data structure: time 0.005812/1.013, allocations: 2.641 MB / 1.473 GB, free: 15.65 MB / 1.201 GB
Notification: Performance of prepare preOptimizeDAE: time 4.007e-05/1.013, allocations: 19.97 kB / 1.473 GB, free: 15.63 MB / 1.201 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003977/1.017, allocations: 0.623 MB / 1.474 GB, free: 15 MB / 1.201 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004776/1.022, allocations: 2.239 MB / 1.476 GB, free: 12.71 MB / 1.201 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.689e-05/1.022, allocations: 81.98 kB / 1.476 GB, free: 12.64 MB / 1.201 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002672/1.023, allocations: 115.9 kB / 1.476 GB, free: 12.52 MB / 1.201 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002444/1.025, allocations: 1.292 MB / 1.478 GB, free: 11.19 MB / 1.201 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.788e-05/1.025, allocations: 4 kB / 1.478 GB, free: 11.19 MB / 1.201 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001129/1.025, allocations: 47.94 kB / 1.478 GB, free: 11.14 MB / 1.201 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.678e-05/1.025, allocations: 34 kB / 1.478 GB, free: 11.11 MB / 1.201 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002269/1.028, allocations: 1.019 MB / 1.479 GB, free: 10.09 MB / 1.201 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.007565/1.035, allocations: 5.54 MB / 1.484 GB, free: 4.219 MB / 1.201 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00242/1.038, allocations: 0.8998 MB / 1.485 GB, free: 3.305 MB / 1.201 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001063/1.039, allocations: 494.4 kB / 1.485 GB, free: 2.82 MB / 1.201 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002154/1.039, allocations: 113.6 kB / 1.485 GB, free: 2.691 MB / 1.201 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001194/1.04, allocations: 0.5886 MB / 1.486 GB, free: 2.09 MB / 1.201 GB
Notification: Performance of pre-optimization done (n=68): time 2.785e-06/1.04, allocations: 3.938 kB / 1.486 GB, free: 2.086 MB / 1.201 GB
Notification: Performance of matching and sorting (n=68): time 0.003943/1.044, allocations: 1.472 MB / 1.487 GB, free: 0.5898 MB / 1.201 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.787e-05/1.044, allocations: 59.97 kB / 1.488 GB, free: 0.5195 MB / 1.201 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002632/1.047, allocations: 1.725 MB / 1.489 GB, free: 14.79 MB / 1.217 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001371/1.047, allocations: 45.64 kB / 1.489 GB, free: 14.74 MB / 1.217 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007642/1.048, allocations: 0.7886 MB / 1.49 GB, free: 13.95 MB / 1.217 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002747/1.048, allocations: 253.8 kB / 1.49 GB, free: 13.7 MB / 1.217 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004486/1.048, allocations: 286.8 kB / 1.491 GB, free: 13.41 MB / 1.217 GB
Notification: Performance of setup shared object (initialization): time 0.00015/1.049, allocations: 361.9 kB / 1.491 GB, free: 13.05 MB / 1.217 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001382/1.05, allocations: 0.7641 MB / 1.492 GB, free: 12.29 MB / 1.217 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001506/1.051, allocations: 1.042 MB / 1.493 GB, free: 11.14 MB / 1.217 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002771/1.054, allocations: 1.698 MB / 1.494 GB, free: 9.363 MB / 1.217 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.687e-06/1.054, allocations: 4 kB / 1.494 GB, free: 9.359 MB / 1.217 GB
Notification: Performance of matching and sorting (n=168) (initialization): time 0.003686/1.058, allocations: 2.136 MB / 1.496 GB, free: 7.207 MB / 1.217 GB
Notification: Performance of prepare postOptimizeDAE: time 4.198e-05/1.058, allocations: 33.7 kB / 1.496 GB, free: 7.168 MB / 1.217 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.416e-05/1.058, allocations: 4.406 kB / 1.496 GB, free: 7.164 MB / 1.217 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005202/1.059, allocations: 160.7 kB / 1.497 GB, free: 7.004 MB / 1.217 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001199/1.06, allocations: 263.6 kB / 1.497 GB, free: 6.746 MB / 1.217 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0008932/1.061, allocations: 1.236 MB / 1.498 GB, free: 5.461 MB / 1.217 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001399/1.062, allocations: 151.2 kB / 1.498 GB, free: 5.312 MB / 1.217 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001319/1.062, allocations: 67.97 kB / 1.498 GB, free: 5.246 MB / 1.217 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001802/1.064, allocations: 1.065 MB / 1.499 GB, free: 4.172 MB / 1.217 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001392/1.065, allocations: 0.9481 MB / 1.5 GB, free: 3.125 MB / 1.217 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002397/1.068, allocations: 1.499 MB / 1.502 GB, free: 1.547 MB / 1.217 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.98e-06/1.068, allocations: 0 / 1.502 GB, free: 1.547 MB / 1.217 GB
Notification: Performance of matching and sorting (n=168) (initialization_lambda0): time 0.003581/1.071, allocations: 1.945 MB / 1.504 GB, free: 15.59 MB / 1.232 GB
Notification: Performance of prepare postOptimizeDAE: time 3.928e-05/1.072, allocations: 41.62 kB / 1.504 GB, free: 15.54 MB / 1.232 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.415e-05/1.072, allocations: 8 kB / 1.504 GB, free: 15.53 MB / 1.232 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006555/1.072, allocations: 177.1 kB / 1.504 GB, free: 15.36 MB / 1.232 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001052/1.073, allocations: 251.5 kB / 1.504 GB, free: 15.11 MB / 1.232 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005165/1.078, allocations: 3.396 MB / 1.507 GB, free: 11.5 MB / 1.232 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001534/1.08, allocations: 127.5 kB / 1.508 GB, free: 11.38 MB / 1.232 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001429/1.08, allocations: 51.98 kB / 1.508 GB, free: 11.33 MB / 1.232 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 24
 * Number of states: 0 ()
 * Number of discrete variables: 6 (y.count,$PRE.y.count,y.T_start,$PRE.y.T_start,$whenCondition1,conPID.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (129):
 * Single equations (assignments): 124
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003635/1.081, allocations: 241.7 kB / 1.508 GB, free: 11.09 MB / 1.232 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003384/1.081, allocations: 174.9 kB / 1.508 GB, free: 10.91 MB / 1.232 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002708/1.084, allocations: 1.122 MB / 1.509 GB, free: 9.77 MB / 1.232 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002024/1.086, allocations: 0.971 MB / 1.51 GB, free: 8.766 MB / 1.232 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.636e-06/1.086, allocations: 0 / 1.51 GB, free: 8.766 MB / 1.232 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006121/1.086, allocations: 347.7 kB / 1.51 GB, free: 8.406 MB / 1.232 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002489/1.086, allocations: 12 kB / 1.51 GB, free: 8.395 MB / 1.232 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009208/1.087, allocations: 55.94 kB / 1.51 GB, free: 8.34 MB / 1.232 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000145/1.088, allocations: 52.48 kB / 1.51 GB, free: 8.289 MB / 1.232 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002957/1.091, allocations: 1.113 MB / 1.512 GB, free: 7.16 MB / 1.232 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.002958/1.094, allocations: 1.633 MB / 1.513 GB, free: 5.512 MB / 1.232 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0009061/1.094, allocations: 416.2 kB / 1.514 GB, free: 5.105 MB / 1.232 GB
Notification: Performance of sorting global known variables: time 0.001849/1.096, allocations: 1.158 MB / 1.515 GB, free: 3.957 MB / 1.232 GB
Notification: Performance of Backend: time 4.31e-07/1.096, allocations: 0 / 1.515 GB, free: 3.957 MB / 1.232 GB
Notification: Performance of simCode: created initialization part: time 0.006897/1.103, allocations: 3.045 MB / 1.518 GB, free: 0.8789 MB / 1.232 GB
Notification: Performance of SimCode: time 0.007428/1.111, allocations: 4.258 MB / 1.522 GB, free: 12.57 MB / 1.248 GB
Notification: Performance of Templates: time 0.6052/1.716, allocations: 46.44 MB / 1.567 GB, free: 333.9 MB / 1.279 GB
make -j1 -f Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y.makefile
(rm -f Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y.pipe >> ../files/Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y.sim & ./Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_Movers_Examples_ClosedLoop_y.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.Movers.Examples.ClosedLoop_y.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches