Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal.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-master/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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(IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal")
translateModel(IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0007898/0.0007899, allocations: 98.03 kB / 15.36 MB, free: 0.7344 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.007706/0.007706, allocations: 168.4 kB / 16.26 MB, free: 6.648 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.491/1.491, allocations: 223.3 MB / 240.3 MB, free: 5.336 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9699/0.9699, allocations: 135.3 MB / 426.7 MB, free: 14.34 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004508/0.0004511, allocations: 8.281 kB / 0.5076 GB, free: 4.75 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1784/0.1789, allocations: 82.32 MB / 0.588 GB, free: 2.605 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal): time 0.4096/0.5885, allocations: 78.5 MB / 0.6646 GB, free: 3.832 MB / 0.4981 GB
Notification: Performance of NFInst.instExpressions: time 0.03262/0.6212, allocations: 19.11 MB / 0.6833 GB, free: 6.176 MB / 0.5137 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004993/0.6262, allocations: 92.53 kB / 0.6834 GB, free: 6.137 MB / 0.5137 GB
Notification: Performance of NFTyping.typeComponents: time 0.004353/0.6306, allocations: 0.9762 MB / 0.6843 GB, free: 5.609 MB / 0.5137 GB
Notification: Performance of NFTyping.typeBindings: time 0.0105/0.6412, allocations: 2.586 MB / 0.6868 GB, free: 4.125 MB / 0.5137 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007465/0.6486, allocations: 2.167 MB / 0.689 GB, free: 2.918 MB / 0.5137 GB
Notification: Performance of NFFlatten.flatten: time 0.03338/0.682, allocations: 20.74 MB / 0.7092 GB, free: 11.53 MB / 0.5294 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01442/0.6965, allocations: 6.022 MB / 0.7151 GB, free: 8.074 MB / 0.5294 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0175/0.7141, allocations: 4.665 MB / 0.7196 GB, free: 5.43 MB / 0.5294 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01406/0.7282, allocations: 4.855 MB / 0.7244 GB, free: 0.5508 MB / 0.5294 GB
Notification: Performance of NFPackage.collectConstants: time 0.002106/0.7304, allocations: 256 kB / 0.7246 GB, free: 308 kB / 0.5294 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006987/0.7374, allocations: 1.49 MB / 0.7261 GB, free: 14.81 MB / 0.545 GB
Notification: Performance of NFScalarize.scalarize: time 0.002672/0.7401, allocations: 1.26 MB / 0.7273 GB, free: 13.54 MB / 0.545 GB
Notification: Performance of NFVerifyModel.verify: time 0.006551/0.7467, allocations: 2.901 MB / 0.7302 GB, free: 10.62 MB / 0.545 GB
Notification: Performance of NFConvertDAE.convert: time 0.01323/0.7599, allocations: 8.57 MB / 0.7385 GB, free: 2.023 MB / 0.545 GB
Notification: Performance of FrontEnd - DAE generated: time 6.733e-06/0.76, allocations: 0 / 0.7385 GB, free: 2.023 MB / 0.545 GB
Notification: Performance of FrontEnd: time 2.675e-06/0.76, allocations: 0 / 0.7385 GB, free: 2.023 MB / 0.545 GB
Notification: Performance of Transformations before backend: time 0.0002746/0.7603, allocations: 0 / 0.7385 GB, free: 2.023 MB / 0.545 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 834
 * Number of variables: 834
Notification: Performance of Generate backend data structure: time 0.01279/0.7731, allocations: 5.348 MB / 0.7437 GB, free: 12.59 MB / 0.5606 GB
Notification: Performance of prepare preOptimizeDAE: time 6.055e-05/0.7731, allocations: 12.03 kB / 0.7438 GB, free: 12.57 MB / 0.5606 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005083/0.7782, allocations: 0.8445 MB / 0.7446 GB, free: 11.72 MB / 0.5606 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0111/0.7893, allocations: 5.273 MB / 0.7497 GB, free: 6.371 MB / 0.5606 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002732/0.7897, allocations: 259.1 kB / 0.75 GB, free: 6.117 MB / 0.5606 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0009596/0.7906, allocations: 343.9 kB / 0.7503 GB, free: 5.781 MB / 0.5606 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01131/0.8019, allocations: 5.705 MB / 0.7559 GB, free: 15.84 MB / 0.5762 GB
Notification: Performance of preOpt findStateOrder (simulation): time 7.377e-05/0.8021, allocations: 15.86 kB / 0.7559 GB, free: 15.82 MB / 0.5762 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005029/0.8026, allocations: 144 kB / 0.756 GB, free: 15.68 MB / 0.5762 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001247/0.8027, allocations: 118 kB / 0.7561 GB, free: 15.56 MB / 0.5762 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01037/0.8131, allocations: 5.554 MB / 0.7616 GB, free: 9.996 MB / 0.5762 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.04066/0.8538, allocations: 23.94 MB / 0.7849 GB, free: 0.9258 MB / 0.5919 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005345/0.8592, allocations: 2.773 MB / 0.7877 GB, free: 14.16 MB / 0.6075 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003135/0.8624, allocations: 1.917 MB / 0.7895 GB, free: 12.24 MB / 0.6075 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01427/0.8767, allocations: 7.085 MB / 0.7964 GB, free: 4.84 MB / 0.6075 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003399/0.8801, allocations: 1.925 MB / 0.7983 GB, free: 2.898 MB / 0.6075 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004986/0.8851, allocations: 1.254 MB / 0.7995 GB, free: 1.641 MB / 0.6075 GB
Notification: Performance of pre-optimization done (n=156): time 1.532e-05/0.8852, allocations: 0 / 0.7995 GB, free: 1.641 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=156): time 0.02334/0.9085, allocations: 7.609 MB / 0.807 GB, free: 9.953 MB / 0.6231 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.361e-05/0.9086, allocations: 72.66 kB / 0.807 GB, free: 9.871 MB / 0.6231 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.009763/0.9184, allocations: 4.898 MB / 0.8118 GB, free: 4.988 MB / 0.6231 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007534/0.9192, allocations: 61.7 kB / 0.8119 GB, free: 4.922 MB / 0.6231 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003242/0.9224, allocations: 2.455 MB / 0.8143 GB, free: 2.441 MB / 0.6231 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001426/0.9239, allocations: 0.5548 MB / 0.8148 GB, free: 1.879 MB / 0.6231 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0009026/0.9248, allocations: 219.1 kB / 0.815 GB, free: 1.66 MB / 0.6231 GB
Notification: Performance of setup shared object (initialization): time 9.995e-05/0.9249, allocations: 301.1 kB / 0.8153 GB, free: 1.363 MB / 0.6231 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003496/0.9284, allocations: 1.676 MB / 0.817 GB, free: 15.68 MB / 0.6387 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004669/0.9331, allocations: 2.878 MB / 0.8198 GB, free: 12.25 MB / 0.6387 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007929/0.9411, allocations: 4.593 MB / 0.8243 GB, free: 7.191 MB / 0.6387 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.806e-05/0.9411, allocations: 8 kB / 0.8243 GB, free: 7.184 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=336) (initialization): time 0.01438/0.9555, allocations: 6.083 MB / 0.8302 GB, free: 1.07 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0009848/0.9566, allocations: 1.105 MB / 0.8313 GB, free: 15.5 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.402e-05/0.9567, allocations: 32 kB / 0.8313 GB, free: 15.47 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.07459/1.031, allocations: 11.91 MB / 0.8429 GB, free: 3.543 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003289/1.035, allocations: 0.663 MB / 0.8436 GB, free: 2.879 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009112/1.044, allocations: 5.03 MB / 0.8485 GB, free: 13.77 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00542/1.049, allocations: 331.7 kB / 0.8488 GB, free: 13.45 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007104/1.05, allocations: 167.9 kB / 0.849 GB, free: 13.28 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 1.358e-05/1.05, allocations: 4 kB / 0.849 GB, free: 13.28 MB / 0.67 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01086/1.061, allocations: 5.337 MB / 0.8542 GB, free: 7.922 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001057/1.061, allocations: 32 kB / 0.8542 GB, free: 7.891 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.4202/1.481, allocations: 11.66 MB / 0.8656 GB, free: 203.1 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002799/1.484, allocations: 0.6593 MB / 0.8663 GB, free: 203.1 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01118/1.495, allocations: 8.032 MB / 0.8741 GB, free: 199.9 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006416/1.502, allocations: 322.4 kB / 0.8744 GB, free: 199.9 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008288/1.503, allocations: 156.4 kB / 0.8746 GB, free: 199.9 MB / 0.67 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 149
 * Number of states: 0 ()
 * Number of discrete variables: 7 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,nRes.y,allowFlowReversal.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (285):
 * Single equations (assignments): 280
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
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): 3 systems
   {(11,13), (10,11), (2,5)}
Notification: Performance of prepare postOptimizeDAE: time 0.00422/1.507, allocations: 1.551 MB / 0.8761 GB, free: 199.7 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00164/1.508, allocations: 469.3 kB / 0.8765 GB, free: 199.7 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01137/1.52, allocations: 4.847 MB / 0.8813 GB, free: 198.5 MB / 0.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.932e-05/1.52, allocations: 17.84 kB / 0.8813 GB, free: 198.5 MB / 0.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.641e-06/1.52, allocations: 3.094 kB / 0.8813 GB, free: 198.5 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02769/1.548, allocations: 7.043 MB / 0.8882 GB, free: 195.4 MB / 0.67 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 postOpt removeSimpleEquations (simulation): time 0.04415/1.592, allocations: 13.18 MB / 0.901 GB, free: 190.5 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.804e-05/1.592, allocations: 1.25 kB / 0.901 GB, free: 190.5 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002557/1.594, allocations: 370 kB / 0.9014 GB, free: 190.5 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.07433/1.669, allocations: 11.9 MB / 0.913 GB, free: 189.4 MB / 0.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0005973/1.669, allocations: 41.31 kB / 0.913 GB, free: 189.3 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00709/1.677, allocations: 4.37 MB / 0.9173 GB, free: 187.1 MB / 0.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.188e-06/1.677, allocations: 4.906 kB / 0.9173 GB, free: 187.1 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02994/1.707, allocations: 9.71 MB / 0.9268 GB, free: 183.1 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004447/1.711, allocations: 1.072 MB / 0.9278 GB, free: 182.4 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001803/1.713, allocations: 31.53 kB / 0.9279 GB, free: 182.4 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004539/1.717, allocations: 270.7 kB / 0.9281 GB, free: 182.3 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006108/1.718, allocations: 105.1 kB / 0.9282 GB, free: 182.2 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004481/1.719, allocations: 80.3 kB / 0.9283 GB, free: 182.2 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.007073/1.726, allocations: 3.351 MB / 0.9316 GB, free: 180.5 MB / 0.67 GB
Notification: Performance of sort global known variables: time 7.01e-07/1.726, allocations: 0 / 0.9316 GB, free: 180.5 MB / 0.67 GB
Notification: Performance of remove unused functions: time 0.01098/1.737, allocations: 2.655 MB / 0.9342 GB, free: 180.2 MB / 0.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 4 (pump.vol.dynBal.U,hea.outCon.T,val.filter.s[1],val.filter.s[2])
 * Number of discrete variables: 3 ($whenCondition1,pulse.T_start,pulse.count)
 * Number of discrete states: 1 (pulse.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (128):
 * Single equations (assignments): 119
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 2
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
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): 3 systems
   {(10,3), (2,5), (10,11)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.001761/1.738, allocations: 0.5136 MB / 0.9347 GB, free: 180 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.0173/1.756, allocations: 7.501 MB / 0.942 GB, free: 173.2 MB / 0.67 GB
Notification: Performance of simCode: created event and clocks part: time 1.182e-05/1.756, allocations: 4 kB / 0.942 GB, free: 173.2 MB / 0.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.006041/1.762, allocations: 2.51 MB / 0.9445 GB, free: 170.7 MB / 0.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01785/1.78, allocations: 2.716 MB / 0.9471 GB, free: 168.1 MB / 0.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02057/1.8, allocations: 11.89 MB / 0.9587 GB, free: 156.2 MB / 0.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00353/1.804, allocations: 3.231 MB / 0.9619 GB, free: 152.9 MB / 0.67 GB
Notification: Performance of simCode: alias equations: time 0.006698/1.811, allocations: 1.712 MB / 0.9635 GB, free: 151.2 MB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00152/1.812, allocations: 347.2 kB / 0.9639 GB, free: 150.8 MB / 0.67 GB
Notification: Performance of SimCode: time 1.173e-06/1.812, allocations: 0 / 0.9639 GB, free: 150.8 MB / 0.67 GB
Notification: Performance of Templates: time 0.1488/1.961, allocations: 107.5 MB / 1.069 GB, free: 44.2 MB / 0.67 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal.sim & ./IDEAS_dev_IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Examples.ResistanceVolumeFlowReversal.pipe 2>&1)