Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Humidifiers.Validation.SprayAirWasher_X_dynamic.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.Humidifiers.Validation.SprayAirWasher_X_dynamic,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Humidifiers.Validation.SprayAirWasher_X_dynamic")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002559/0.002563, allocations: 359.9 kB / 16.59 MB, free: 5.562 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.527/1.527, allocations: 165.8 MB / 183.1 MB, free: 5.449 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 4.351/4.351, allocations: 410.8 MB / 0.6001 GB, free: 15.16 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.002446/0.002445, allocations: 201.2 kB / 0.6668 GB, free: 6.93 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0006128/0.000613, allocations: 16 kB / 0.7429 GB, free: 8.965 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4074/0.4081, allocations: 67.44 MB / 0.8087 GB, free: 28.79 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Humidifiers.Validation.SprayAirWasher_X_dynamic): time 0.71/1.118, allocations: 162.3 MB / 0.9672 GB, free: 1.262 MB / 474.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01311/1.131, allocations: 3.621 MB / 0.9707 GB, free: 1.199 MB / 474.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001462/1.133, allocations: 30.09 kB / 0.9708 GB, free: 1.195 MB / 474.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.002723/1.136, allocations: 384.1 kB / 0.9711 GB, free: 1.195 MB / 474.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.006986/1.143, allocations: 1.054 MB / 0.9722 GB, free: 1.039 MB / 474.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004924/1.148, allocations: 0.6451 MB / 0.9728 GB, free: 1.008 MB / 474.7 MB
Notification: Performance of NFFlatten.flatten: time 0.004267/1.152, allocations: 1.563 MB / 0.9743 GB, free: 0.7656 MB / 474.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001532/1.154, allocations: 373.9 kB / 0.9747 GB, free: 0.6992 MB / 474.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004025/1.158, allocations: 0.7543 MB / 0.9754 GB, free: 0.5352 MB / 474.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001697/1.159, allocations: 438.1 kB / 0.9758 GB, free: 464 kB / 474.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002103/1.16, allocations: 19.59 kB / 0.9758 GB, free: 464 kB / 474.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003331/1.163, allocations: 0.5667 MB / 0.9764 GB, free: 420 kB / 474.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0006219/1.164, allocations: 175.4 kB / 0.9766 GB, free: 396 kB / 474.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004691/1.164, allocations: 149 kB / 0.9767 GB, free: 340 kB / 474.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002654/1.167, allocations: 0.7316 MB / 0.9774 GB, free: 264 kB / 474.7 MB
Notification: Performance of FrontEnd - DAE generated: time 9.709e-06/1.167, allocations: 3.25 kB / 0.9774 GB, free: 264 kB / 474.7 MB
Notification: Performance of FrontEnd: time 2.876e-06/1.167, allocations: 0 / 0.9774 GB, free: 264 kB / 474.7 MB
Notification: Performance of Transformations before backend: time 2.53e-05/1.167, allocations: 0 / 0.9774 GB, free: 264 kB / 474.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 97
 * Number of variables: 97
Notification: Performance of Generate backend data structure: time 0.004906/1.172, allocations: 0.9124 MB / 0.9783 GB, free: 15.64 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 6.28e-05/1.172, allocations: 8 kB / 0.9783 GB, free: 15.64 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003459/1.176, allocations: 238.7 kB / 0.9786 GB, free: 15.59 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002062/1.178, allocations: 0.5164 MB / 0.9791 GB, free: 15.24 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.593e-05/1.178, allocations: 36.58 kB / 0.9791 GB, free: 15.23 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001982/1.178, allocations: 41.55 kB / 0.9791 GB, free: 15.23 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002814/1.181, allocations: 0.5377 MB / 0.9797 GB, free: 15.05 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.028e-05/1.181, allocations: 0 / 0.9797 GB, free: 15.05 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.971e-05/1.181, allocations: 16.78 kB / 0.9797 GB, free: 15.05 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.479e-05/1.181, allocations: 21.3 kB / 0.9797 GB, free: 15.04 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00332/1.185, allocations: 0.5115 MB / 0.9802 GB, free: 14.95 MB / 490.7 MB
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.008666/1.193, allocations: 2.253 MB / 0.9824 GB, free: 13.36 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.00183/1.195, allocations: 358.5 kB / 0.9827 GB, free: 13.2 MB / 490.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006074/1.196, allocations: 142.5 kB / 0.9829 GB, free: 13.18 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.003393/1.199, allocations: 0.8646 MB / 0.9837 GB, free: 12.27 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0008083/1.2, allocations: 203.8 kB / 0.9839 GB, free: 12.16 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=27): time 5.49e-06/1.2, allocations: 1.859 kB / 0.9839 GB, free: 12.16 MB / 490.7 MB
Notification: Performance of matching and sorting (n=27): time 0.002491/1.203, allocations: 447.3 kB / 0.9843 GB, free: 12.04 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.701e-05/1.203, allocations: 91.25 kB / 0.9844 GB, free: 11.94 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002249/1.205, allocations: 0.6495 MB / 0.9851 GB, free: 11.71 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.000125/1.205, allocations: 28.7 kB / 0.9851 GB, free: 11.68 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0004539/1.206, allocations: 317.6 kB / 0.9854 GB, free: 11.52 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.000203/1.206, allocations: 95.83 kB / 0.9855 GB, free: 11.45 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 5.201e-05/1.206, allocations: 7.812 kB / 0.9855 GB, free: 11.45 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 0.0002778/1.206, allocations: 370.5 kB / 0.9858 GB, free: 11.12 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009743/1.207, allocations: 141.9 kB / 0.986 GB, free: 11.09 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001191/1.209, allocations: 284.3 kB / 0.9862 GB, free: 10.89 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001095/1.21, allocations: 176.8 kB / 0.9864 GB, free: 10.86 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.016e-05/1.21, allocations: 0 / 0.9864 GB, free: 10.86 MB / 490.7 MB
Notification: Performance of matching and sorting (n=45) (initialization): time 0.002757/1.213, allocations: 482.9 kB / 0.9869 GB, free: 10.71 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0002532/1.213, allocations: 201.2 kB / 0.9871 GB, free: 10.48 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.633e-05/1.213, allocations: 11.22 kB / 0.9871 GB, free: 10.48 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 3.632e-05/1.213, allocations: 8.281 kB / 0.9871 GB, free: 10.48 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001277/1.214, allocations: 84.05 kB / 0.9872 GB, free: 10.46 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3e-05/1.214, allocations: 6.031 kB / 0.9872 GB, free: 10.46 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001874/1.216, allocations: 90.19 kB / 0.9873 GB, free: 10.42 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001348/1.216, allocations: 20.84 kB / 0.9873 GB, free: 10.41 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.199e-05/1.217, allocations: 5.812 kB / 0.9873 GB, free: 10.41 MB / 490.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002289/1.219, allocations: 404.7 kB / 0.9877 GB, free: 10.33 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.873e-05/1.219, allocations: 3.031 kB / 0.9877 GB, free: 10.33 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 1.991e-05/1.219, allocations: 7.531 kB / 0.9877 GB, free: 10.33 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001098/1.22, allocations: 84.39 kB / 0.9878 GB, free: 10.31 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.543e-05/1.22, allocations: 21.75 kB / 0.9878 GB, free: 10.3 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001493/1.222, allocations: 63.38 kB / 0.9878 GB, free: 10.27 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001163/1.222, allocations: 24.98 kB / 0.9879 GB, free: 10.27 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 17
 * Number of states: 0 ()
 * Number of discrete variables: 5 ($whenCondition1,$PRE.XSet.nextTimeEvent,XSet.nextTimeEvent,$PRE.XSet.nextTimeEventScaled,XSet.nextTimeEventScaled)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (45):
 * Single equations (assignments): 45
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0007488/1.223, allocations: 282.8 kB / 0.9881 GB, free: 10.06 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002642/1.223, allocations: 58.78 kB / 0.9882 GB, free: 10.03 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001508/1.224, allocations: 332 kB / 0.9885 GB, free: 9.918 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.809e-05/1.224, allocations: 10.61 kB / 0.9885 GB, free: 9.91 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.235e-06/1.224, allocations: 5.703 kB / 0.9885 GB, free: 9.906 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.000608/1.225, allocations: 174.2 kB / 0.9887 GB, free: 9.762 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004891/1.226, allocations: 3.25 kB / 0.9887 GB, free: 9.762 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001482/1.227, allocations: 27.83 kB / 0.9887 GB, free: 9.754 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001475/1.227, allocations: 16.23 kB / 0.9887 GB, free: 9.746 MB / 490.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002146/1.23, allocations: 449.7 kB / 0.9892 GB, free: 9.512 MB / 490.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.001381/1.231, allocations: 0.6941 MB / 0.9898 GB, free: 9.137 MB / 490.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0003301/1.231, allocations: 119 kB / 0.99 GB, free: 9.113 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.001092/1.232, allocations: 470.7 kB / 0.9904 GB, free: 8.953 MB / 490.7 MB
Notification: Performance of Backend: time 7.62e-07/1.232, allocations: 0 / 0.9904 GB, free: 8.953 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.004267/1.237, allocations: 1.01 MB / 0.9914 GB, free: 8.621 MB / 490.7 MB
Notification: Performance of SimCode: time 0.004214/1.241, allocations: 1.788 MB / 0.9931 GB, free: 7.367 MB / 490.7 MB
Notification: Performance of Templates: time 0.03713/1.278, allocations: 12.82 MB / 1.006 GB, free: 0.8242 MB / 490.7 MB