Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Interfaces.Examples.Humidifier_u.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.Interfaces.Examples.Humidifier_u,tolerance=1e-07,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Interfaces.Examples.Humidifier_u")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.003764/0.00377, allocations: 354.1 kB / 16.59 MB, free: 5.57 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 1.391/1.391, allocations: 165.8 MB / 183.1 MB, free: 5.43 MB / 138.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 3.871/3.871, allocations: 410.7 MB / 0.6001 GB, free: 15.11 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001766/0.001766, allocations: 187 kB / 0.6668 GB, free: 6.953 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004532/0.0004533, allocations: 15.98 kB / 0.7429 GB, free: 8.98 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3922/0.3927, allocations: 67.43 MB / 0.8087 GB, free: 28.82 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Interfaces.Examples.Humidifier_u): time 1.733/2.126, allocations: 0.5126 GB / 1.321 GB, free: 18.82 MB / 0.6042 GB
Notification: Performance of NFInst.instExpressions: time 0.0788/2.205, allocations: 39.13 MB / 1.36 GB, free: 11.62 MB / 0.6355 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01052/2.215, allocations: 222.5 kB / 1.36 GB, free: 11.41 MB / 0.6355 GB
Notification: Performance of NFTyping.typeComponents: time 0.0157/2.231, allocations: 3.308 MB / 1.363 GB, free: 8.078 MB / 0.6355 GB
Notification: Performance of NFTyping.typeBindings: time 0.05401/2.285, allocations: 13.64 MB / 1.376 GB, free: 10.38 MB / 0.6511 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0202/2.305, allocations: 4.531 MB / 1.381 GB, free: 5.898 MB / 0.6511 GB
Notification: Performance of NFFlatten.flatten: time 0.04081/2.346, allocations: 22.5 MB / 1.403 GB, free: 15.34 MB / 0.6823 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01222/2.358, allocations: 4.736 MB / 1.407 GB, free: 10.54 MB / 0.6823 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01951/2.378, allocations: 6.204 MB / 1.413 GB, free: 4.305 MB / 0.6823 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.6208/2.999, allocations: 5.661 MB / 1.419 GB, free: 24.15 MB / 0.6823 GB
Notification: Performance of NFPackage.collectConstants: time 0.003034/3.002, allocations: 285.3 kB / 1.419 GB, free: 24.15 MB / 0.6823 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02006/3.022, allocations: 4.188 MB / 1.423 GB, free: 24.15 MB / 0.6823 GB
Notification: Performance of NFScalarize.scalarize: time 0.005819/3.028, allocations: 2.261 MB / 1.425 GB, free: 24.15 MB / 0.6823 GB
Notification: Performance of NFVerifyModel.verify: time 0.00536/3.033, allocations: 1.587 MB / 1.427 GB, free: 24.12 MB / 0.6823 GB
Notification: Performance of NFConvertDAE.convert: time 0.02039/3.054, allocations: 10.17 MB / 1.437 GB, free: 23.41 MB / 0.6823 GB
Notification: Performance of FrontEnd - DAE generated: time 7.645e-06/3.054, allocations: 0 / 1.437 GB, free: 23.41 MB / 0.6823 GB
Notification: Performance of FrontEnd: time 2.905e-06/3.054, allocations: 1.781 kB / 1.437 GB, free: 23.41 MB / 0.6823 GB
Notification: Performance of Transformations before backend: time 0.0004076/3.054, allocations: 0 / 1.437 GB, free: 23.41 MB / 0.6823 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1309
 * Number of variables: 1309
Notification: Performance of Generate backend data structure: time 0.03912/3.093, allocations: 7.835 MB / 1.445 GB, free: 20.01 MB / 0.6823 GB
Notification: Performance of prepare preOptimizeDAE: time 5.258e-05/3.093, allocations: 8.469 kB / 1.445 GB, free: 20.01 MB / 0.6823 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01843/3.112, allocations: 1.961 MB / 1.447 GB, free: 19.6 MB / 0.6823 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01535/3.127, allocations: 4.729 MB / 1.451 GB, free: 18.72 MB / 0.6823 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005411/3.128, allocations: 403 kB / 1.452 GB, free: 18.71 MB / 0.6823 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002167/3.13, allocations: 0.5394 MB / 1.452 GB, free: 18.7 MB / 0.6823 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02059/3.151, allocations: 5.733 MB / 1.458 GB, free: 18.52 MB / 0.6823 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001943/3.151, allocations: 9.969 kB / 1.458 GB, free: 18.52 MB / 0.6823 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001075/3.152, allocations: 208.9 kB / 1.458 GB, free: 18.52 MB / 0.6823 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003936/3.152, allocations: 260.6 kB / 1.458 GB, free: 18.51 MB / 0.6823 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02144/3.174, allocations: 6.086 MB / 1.464 GB, free: 18.46 MB / 0.6823 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.05173/3.225, allocations: 23.64 MB / 1.487 GB, free: 23.89 MB / 0.698 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01174/3.237, allocations: 5.083 MB / 1.492 GB, free: 22.97 MB / 0.698 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006742/3.244, allocations: 2.437 MB / 1.494 GB, free: 22.94 MB / 0.698 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0008612/3.245, allocations: 262.1 kB / 1.495 GB, free: 22.75 MB / 0.698 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001093/3.245, allocations: 92.94 kB / 1.495 GB, free: 22.7 MB / 0.698 GB
Notification: Performance of pre-optimization done (n=397): time 7.695e-06/3.245, allocations: 0 / 1.495 GB, free: 22.7 MB / 0.698 GB
Notification: Performance of matching and sorting (n=405): time 0.048/3.293, allocations: 13.03 MB / 1.508 GB, free: 20.02 MB / 0.698 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.798e-05/3.293, allocations: 98.56 kB / 1.508 GB, free: 19.95 MB / 0.698 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008537/3.302, allocations: 3.985 MB / 1.512 GB, free: 19.63 MB / 0.698 GB
Notification: Performance of collectPreVariables (initialization): time 0.001127/3.303, allocations: 121.7 kB / 1.512 GB, free: 19.6 MB / 0.698 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002845/3.306, allocations: 2.674 MB / 1.514 GB, free: 18.8 MB / 0.698 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002326/3.308, allocations: 1.406 MB / 1.516 GB, free: 17.88 MB / 0.698 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004133/3.309, allocations: 75.44 kB / 1.516 GB, free: 17.88 MB / 0.698 GB
Notification: Performance of setup shared object (initialization): time 0.000391/3.309, allocations: 458.6 kB / 1.516 GB, free: 17.57 MB / 0.698 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005382/3.314, allocations: 1.8 MB / 1.518 GB, free: 17.56 MB / 0.698 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006455/3.321, allocations: 2.599 MB / 1.52 GB, free: 16.79 MB / 0.698 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006152/3.327, allocations: 2.107 MB / 1.523 GB, free: 16.57 MB / 0.698 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.844e-05/3.327, allocations: 1.422 kB / 1.523 GB, free: 16.57 MB / 0.698 GB
Notification: Performance of matching and sorting (n=501) (initialization): time 0.01852/3.346, allocations: 5.518 MB / 1.528 GB, free: 15.46 MB / 0.698 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000219/3.346, allocations: 339.4 kB / 1.528 GB, free: 15.07 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.635e-05/3.346, allocations: 7.719 kB / 1.528 GB, free: 15.07 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004264/3.35, allocations: 0.6024 MB / 1.529 GB, free: 14.82 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007599/3.358, allocations: 0.7676 MB / 1.53 GB, free: 14.71 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01097/3.369, allocations: 11.76 MB / 1.541 GB, free: 3.766 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01208/3.381, allocations: 0.539 MB / 1.542 GB, free: 3.555 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008816/3.382, allocations: 134.3 kB / 1.542 GB, free: 3.547 MB / 0.698 GB
Notification: Performance of prepare postOptimizeDAE: time 1.295e-05/3.382, allocations: 5.844 kB / 1.542 GB, free: 3.547 MB / 0.698 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01509/3.397, allocations: 4.819 MB / 1.546 GB, free: 2.824 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.693e-05/3.397, allocations: 10.77 kB / 1.546 GB, free: 2.82 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001945/3.399, allocations: 437.2 kB / 1.547 GB, free: 2.641 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007001/3.406, allocations: 0.7397 MB / 1.548 GB, free: 2.543 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01926/3.425, allocations: 17.76 MB / 1.565 GB, free: 0.8438 MB / 0.7136 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01193/3.437, allocations: 0.5367 MB / 1.565 GB, free: 392 kB / 0.7136 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008925/3.438, allocations: 140.7 kB / 1.566 GB, free: 288 kB / 0.7136 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 32
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (457):
 * Single equations (assignments): 435
 * Array equations: 8
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 2
 * Torn equation systems: 12
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 2 {1,1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 4 {(1,100.0%) 3,(1,100.0%) 3,(1,100.0%) 3,(1,100.0%) 3}
 * Non-linear torn systems: 8 {1 3,1 3,1 3,1 3,1 3,1 3,1 3,1 3}
Notification: Performance of prepare postOptimizeDAE: time 0.005242/3.444, allocations: 1.408 MB / 1.567 GB, free: 15.5 MB / 0.7292 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00215/3.446, allocations: 0.5442 MB / 1.567 GB, free: 14.95 MB / 0.7292 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01646/3.462, allocations: 5.123 MB / 1.572 GB, free: 11.68 MB / 0.7292 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01358/3.476, allocations: 4.226 MB / 1.577 GB, free: 8.902 MB / 0.7292 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.626e-05/3.476, allocations: 4 kB / 1.577 GB, free: 8.898 MB / 0.7292 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005176/3.481, allocations: 1.083 MB / 1.578 GB, free: 8.09 MB / 0.7292 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001897/3.483, allocations: 81.8 kB / 1.578 GB, free: 8.066 MB / 0.7292 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009497/3.493, allocations: 434.1 kB / 1.578 GB, free: 7.699 MB / 0.7292 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00109/3.494, allocations: 283 kB / 1.578 GB, free: 7.457 MB / 0.7292 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02139/3.515, allocations: 5.241 MB / 1.584 GB, free: 3.832 MB / 0.7292 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.02106/3.536, allocations: 7.43 MB / 1.591 GB, free: 14.96 MB / 0.7448 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.005932/3.542, allocations: 2.058 MB / 1.593 GB, free: 13.7 MB / 0.7448 GB
Notification: Performance of sorting global known variables: time 0.007207/3.549, allocations: 2.663 MB / 1.595 GB, free: 11.82 MB / 0.7448 GB
Notification: Performance of Backend: time 2.925e-06/3.55, allocations: 4 kB / 1.595 GB, free: 11.81 MB / 0.7448 GB
Notification: Performance of simCode: created initialization part: time 0.0309/3.58, allocations: 9.143 MB / 1.604 GB, free: 4.781 MB / 0.7448 GB
Notification: Performance of SimCode: time 0.05007/3.631, allocations: 16.64 MB / 1.621 GB, free: 5.41 MB / 0.7605 GB
Notification: Performance of Templates: time 0.7837/4.414, allocations: 143.2 MB / 1.76 GB, free: 418.9 MB / 0.8386 GB