Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.Fluid.Interfaces.Examples.Humidifier_u.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/IDEAS 3.0.0/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/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(IDEAS.Fluid.Interfaces.Examples.Humidifier_u,tolerance=1e-07,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Interfaces.Examples.Humidifier_u")
translateModel(IDEAS.Fluid.Interfaces.Examples.Humidifier_u,tolerance=1e-07,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Interfaces.Examples.Humidifier_u")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001555/0.001555, allocations: 109.2 kB / 16.41 MB, free: 6.465 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.001716/0.001716, allocations: 188.3 kB / 17.34 MB, free: 5.711 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.308/1.308, allocations: 222.9 MB / 241.1 MB, free: 15.13 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.7741/0.7741, allocations: 132.2 MB / 423.4 MB, free: 6.57 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001263/0.001263, allocations: 72.52 kB / 0.5821 GB, free: 23.58 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1262/0.1275, allocations: 80.21 MB / 0.6604 GB, free: 10.19 MB / 0.4981 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Interfaces.Examples.Humidifier_u): time 1.19/1.318, allocations: 0.5825 GB / 1.243 GB, free: 31.21 MB / 0.8106 GB
Notification: Performance of NFInst.instExpressions: time 0.04259/1.361, allocations: 36.3 MB / 1.278 GB, free: 12.78 MB / 0.8262 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.008954/1.37, allocations: 271.1 kB / 1.279 GB, free: 12.61 MB / 0.8262 GB
Notification: Performance of NFTyping.typeComponents: time 0.01147/1.381, allocations: 4.44 MB / 1.283 GB, free: 8.559 MB / 0.8262 GB
Notification: Performance of NFTyping.typeBindings: time 0.03531/1.416, allocations: 14.47 MB / 1.297 GB, free: 10.04 MB / 0.8419 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01185/1.428, allocations: 4.919 MB / 1.302 GB, free: 5.141 MB / 0.8419 GB
Notification: Performance of NFFlatten.flatten: time 0.02465/1.453, allocations: 19.38 MB / 1.321 GB, free: 1.707 MB / 0.8575 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.009978/1.463, allocations: 6.522 MB / 1.327 GB, free: 11.09 MB / 0.8731 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01756/1.481, allocations: 8.933 MB / 1.336 GB, free: 2.121 MB / 0.8731 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01074/1.491, allocations: 6.093 MB / 1.342 GB, free: 12.06 MB / 0.8887 GB
Notification: Performance of NFPackage.collectConstants: time 0.002202/1.494, allocations: 0.7422 MB / 1.343 GB, free: 11.32 MB / 0.8887 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01993/1.513, allocations: 10.79 MB / 1.353 GB, free: 0.5039 MB / 0.8887 GB
Notification: Performance of NFScalarize.scalarize: time 0.003764/1.517, allocations: 2.789 MB / 1.356 GB, free: 13.71 MB / 0.9044 GB
Notification: Performance of NFVerifyModel.verify: time 0.007718/1.525, allocations: 4.437 MB / 1.36 GB, free: 9.25 MB / 0.9044 GB
Notification: Performance of NFConvertDAE.convert: time 0.02459/1.55, allocations: 15.25 MB / 1.375 GB, free: 9.945 MB / 0.92 GB
Notification: Performance of FrontEnd - DAE generated: time 5.992e-06/1.55, allocations: 0 / 1.375 GB, free: 9.945 MB / 0.92 GB
Notification: Performance of FrontEnd: time 1.844e-06/1.55, allocations: 4 kB / 1.375 GB, free: 9.941 MB / 0.92 GB
Notification: Performance of Transformations before backend: time 0.0003069/1.55, allocations: 0 / 1.375 GB, free: 9.941 MB / 0.92 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.02666/1.577, allocations: 9.68 MB / 1.385 GB, free: 112 kB / 0.92 GB
Notification: Performance of prepare preOptimizeDAE: time 4.008e-05/1.577, allocations: 12.03 kB / 1.385 GB, free: 100 kB / 0.92 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01289/1.59, allocations: 1.985 MB / 1.386 GB, free: 14.11 MB / 0.9356 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0103/1.6, allocations: 5.293 MB / 1.392 GB, free: 8.742 MB / 0.9356 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003924/1.6, allocations: 402 kB / 1.392 GB, free: 8.348 MB / 0.9356 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000942/1.601, allocations: 0.539 MB / 1.393 GB, free: 7.809 MB / 0.9356 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0113/1.613, allocations: 5.774 MB / 1.398 GB, free: 2 MB / 0.9356 GB
Notification: Performance of preOpt findStateOrder (simulation): time 9.816e-05/1.613, allocations: 7.938 kB / 1.398 GB, free: 1.992 MB / 0.9356 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005172/1.613, allocations: 212 kB / 1.398 GB, free: 1.785 MB / 0.9356 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002364/1.613, allocations: 258.1 kB / 1.399 GB, free: 1.531 MB / 0.9356 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01246/1.626, allocations: 6.111 MB / 1.405 GB, free: 11.41 MB / 0.9512 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.321/1.947, allocations: 23.61 MB / 1.428 GB, free: 430.1 MB / 0.9512 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.007324/1.954, allocations: 5.125 MB / 1.433 GB, free: 427.5 MB / 0.9512 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003695/1.958, allocations: 2.471 MB / 1.435 GB, free: 426.5 MB / 0.9512 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004578/1.958, allocations: 262.3 kB / 1.435 GB, free: 426.3 MB / 0.9512 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.453e-05/1.959, allocations: 87.84 kB / 1.435 GB, free: 426.2 MB / 0.9512 GB
Notification: Performance of pre-optimization done (n=401): time 6.212e-06/1.959, allocations: 0 / 1.435 GB, free: 426.2 MB / 0.9512 GB
Notification: Performance of matching and sorting (n=413): time 0.02565/1.984, allocations: 13.32 MB / 1.448 GB, free: 420 MB / 0.9512 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.132e-05/1.984, allocations: 92.81 kB / 1.449 GB, free: 420 MB / 0.9512 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004728/1.989, allocations: 4.065 MB / 1.453 GB, free: 418.6 MB / 0.9512 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004343/1.989, allocations: 121.1 kB / 1.453 GB, free: 418.5 MB / 0.9512 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001408/1.991, allocations: 2.719 MB / 1.455 GB, free: 416.6 MB / 0.9512 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001061/1.992, allocations: 1.494 MB / 1.457 GB, free: 415.7 MB / 0.9512 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001008/1.993, allocations: 0.7212 MB / 1.457 GB, free: 415.3 MB / 0.9512 GB
Notification: Performance of setup shared object (initialization): time 3.43e-05/1.993, allocations: 304.6 kB / 1.458 GB, free: 415 MB / 0.9512 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002651/1.996, allocations: 1.866 MB / 1.46 GB, free: 414.3 MB / 0.9512 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00303/1.999, allocations: 2.65 MB / 1.462 GB, free: 412.8 MB / 0.9512 GB
Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet.
Notification: Performance of analyzeInitialSystem (initialization): time 0.0241/2.023, allocations: 9.913 MB / 1.472 GB, free: 408.3 MB / 0.9512 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.446e-06/2.023, allocations: 3.969 kB / 1.472 GB, free: 408.3 MB / 0.9512 GB
Notification: Performance of matching and sorting (n=509) (initialization): time 0.009793/2.033, allocations: 5.674 MB / 1.477 GB, free: 405.4 MB / 0.9512 GB
Notification: Performance of prepare postOptimizeDAE: time 2.224e-05/2.033, allocations: 8.781 kB / 1.477 GB, free: 405.4 MB / 0.9512 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.765e-05/2.033, allocations: 9.281 kB / 1.477 GB, free: 405.4 MB / 0.9512 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002442/2.035, allocations: 0.6389 MB / 1.478 GB, free: 405 MB / 0.9512 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003473/2.039, allocations: 0.7618 MB / 1.479 GB, free: 404.8 MB / 0.9512 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005696/2.044, allocations: 12.7 MB / 1.491 GB, free: 392.3 MB / 0.9512 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00537/2.05, allocations: 179.4 kB / 1.491 GB, free: 392.2 MB / 0.9512 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002748/2.05, allocations: 139.6 kB / 1.491 GB, free: 392.2 MB / 0.9512 GB
Warning: The initial conditions are over specified. The following 4 initial equations are redundant, so they are removed from the initialization system:
         hea1.vol.dynBal.medium.p = hea1.vol.dynBal.p_start
         hea3.vol.dynBal.medium.p = hea3.vol.dynBal.p_start
         hea5.vol.dynBal.medium.p = hea5.vol.dynBal.p_start
         hea7.vol.dynBal.medium.p = hea7.vol.dynBal.p_start.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.004544/2.055, allocations: 3.025 MB / 1.494 GB, free: 390.5 MB / 0.9512 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002936/2.058, allocations: 2.622 MB / 1.497 GB, free: 388 MB / 0.9512 GB
Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet.
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02321/2.081, allocations: 9.625 MB / 1.506 GB, free: 378.5 MB / 0.9512 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.027e-05/2.081, allocations: 3.984 kB / 1.506 GB, free: 378.5 MB / 0.9512 GB
Notification: Performance of matching and sorting (n=509) (initialization_lambda0): time 0.008492/2.089, allocations: 5.456 MB / 1.512 GB, free: 373 MB / 0.9512 GB
Notification: Performance of prepare postOptimizeDAE: time 1.791e-05/2.089, allocations: 11.66 kB / 1.512 GB, free: 373 MB / 0.9512 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.426e-05/2.089, allocations: 8 kB / 1.512 GB, free: 373 MB / 0.9512 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001073/2.09, allocations: 460.3 kB / 1.512 GB, free: 372.5 MB / 0.9512 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00314/2.094, allocations: 0.7428 MB / 1.513 GB, free: 371.7 MB / 0.9512 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009703/2.103, allocations: 20.04 MB / 1.532 GB, free: 350.1 MB / 0.9512 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005892/2.109, allocations: 206.2 kB / 1.533 GB, free: 349.9 MB / 0.9512 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002769/2.109, allocations: 136 kB / 1.533 GB, free: 349.8 MB / 0.9512 GB
Warning: The initial conditions are over specified. The following 4 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         hea1.vol.dynBal.medium.p = hea1.vol.dynBal.p_start
         hea3.vol.dynBal.medium.p = hea3.vol.dynBal.p_start
         hea5.vol.dynBal.medium.p = hea5.vol.dynBal.p_start
         hea7.vol.dynBal.medium.p = hea7.vol.dynBal.p_start.
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 (461):
 * Single equations (assignments): 439
 * Array equations: 8
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 12
 * 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): 2 systems
   {1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 8 systems
   {(1,3), (1,3), (1,3), (1,3), (1,3), (1,3), (1,3), (1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.000882/2.11, allocations: 423.7 kB / 1.533 GB, free: 349.4 MB / 0.9512 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008095/2.111, allocations: 0.5823 MB / 1.534 GB, free: 348.8 MB / 0.9512 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007832/2.119, allocations: 5.205 MB / 1.539 GB, free: 343.5 MB / 0.9512 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006032/2.125, allocations: 4.311 MB / 1.543 GB, free: 339.2 MB / 0.9512 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.496e-06/2.125, allocations: 0 / 1.543 GB, free: 339.2 MB / 0.9512 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002053/2.127, allocations: 1.114 MB / 1.544 GB, free: 338 MB / 0.9512 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0007359/2.128, allocations: 83.98 kB / 1.544 GB, free: 337.9 MB / 0.9512 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00359/2.131, allocations: 136.2 kB / 1.544 GB, free: 337.8 MB / 0.9512 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004909/2.132, allocations: 290.8 kB / 1.545 GB, free: 337.5 MB / 0.9512 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.009719/2.142, allocations: 5.275 MB / 1.55 GB, free: 332.3 MB / 0.9512 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.009715/2.151, allocations: 7.578 MB / 1.557 GB, free: 324.7 MB / 0.9512 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002574/2.154, allocations: 2.102 MB / 1.559 GB, free: 322.6 MB / 0.9512 GB
Notification: Performance of sorting global known variables: time 0.004009/2.158, allocations: 2.723 MB / 1.562 GB, free: 319.9 MB / 0.9512 GB
Notification: Performance of Backend: time 1.092e-06/2.158, allocations: 0 / 1.562 GB, free: 319.9 MB / 0.9512 GB
Notification: Performance of simCode: created initialization part: time 0.01677/2.175, allocations: 9.737 MB / 1.571 GB, free: 310.4 MB / 0.9512 GB
Notification: Performance of SimCode: time 0.02105/2.196, allocations: 14.5 MB / 1.586 GB, free: 296 MB / 0.9512 GB
Notification: Performance of Templates: time 0.1851/2.381, allocations: 154.7 MB / 1.737 GB, free: 142.2 MB / 0.9512 GB
make -j1 -f IDEAS_IDEAS.Fluid.Interfaces.Examples.Humidifier_u.makefile
(rm -f IDEAS_IDEAS.Fluid.Interfaces.Examples.Humidifier_u.pipe ; mkfifo IDEAS_IDEAS.Fluid.Interfaces.Examples.Humidifier_u.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.Interfaces.Examples.Humidifier_u.pipe >> ../files/IDEAS_IDEAS.Fluid.Interfaces.Examples.Humidifier_u.sim & ./IDEAS_IDEAS.Fluid.Interfaces.Examples.Humidifier_u  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Fluid.Interfaces.Examples.Humidifier_u.pipe 2>&1)