Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpsParallel.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.Movers.Examples.PumpsParallel,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpsParallel")
translateModel(IDEAS.Fluid.Movers.Examples.PumpsParallel,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpsParallel")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001146/0.001146, 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.01075/0.01075, allocations: 170.4 kB / 16.27 MB, free: 6.652 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.565/1.565, allocations: 223.3 MB / 240.3 MB, free: 5.324 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9593/0.9593, allocations: 135.3 MB / 426.7 MB, free: 14.31 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003988/0.000399, allocations: 8.781 kB / 0.5076 GB, free: 4.711 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1968/0.1972, allocations: 82.31 MB / 0.588 GB, free: 2.57 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Movers.Examples.PumpsParallel): time 0.3576/0.5548, allocations: 65.42 MB / 0.6518 GB, free: 13.11 MB / 0.4981 GB
Notification: Performance of NFInst.instExpressions: time 0.02062/0.5755, allocations: 19.24 MB / 0.6706 GB, free: 15.36 MB / 0.5137 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003039/0.5786, allocations: 81.38 kB / 0.6707 GB, free: 15.32 MB / 0.5137 GB
Notification: Performance of NFTyping.typeComponents: time 0.003283/0.5819, allocations: 1.107 MB / 0.6718 GB, free: 14.73 MB / 0.5137 GB
Notification: Performance of NFTyping.typeBindings: time 0.01009/0.592, allocations: 2.977 MB / 0.6747 GB, free: 13 MB / 0.5137 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006587/0.5986, allocations: 2.149 MB / 0.6768 GB, free: 11.79 MB / 0.5137 GB
Notification: Performance of NFFlatten.flatten: time 0.0116/0.6102, allocations: 8.131 MB / 0.6847 GB, free: 8.773 MB / 0.5137 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003315/0.6136, allocations: 1.833 MB / 0.6865 GB, free: 7.992 MB / 0.5137 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004904/0.6185, allocations: 2.06 MB / 0.6885 GB, free: 7.098 MB / 0.5137 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004091/0.6226, allocations: 1.798 MB / 0.6903 GB, free: 6.336 MB / 0.5137 GB
Notification: Performance of NFPackage.collectConstants: time 0.0006737/0.6233, allocations: 92.31 kB / 0.6904 GB, free: 6.336 MB / 0.5137 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.004689/0.628, allocations: 1.631 MB / 0.692 GB, free: 5.785 MB / 0.5137 GB
Notification: Performance of NFScalarize.scalarize: time 0.001361/0.6294, allocations: 0.5844 MB / 0.6926 GB, free: 5.531 MB / 0.5137 GB
Notification: Performance of NFVerifyModel.verify: time 0.003152/0.6326, allocations: 1.201 MB / 0.6937 GB, free: 4.805 MB / 0.5137 GB
Notification: Performance of NFConvertDAE.convert: time 0.00795/0.6405, allocations: 3.952 MB / 0.6976 GB, free: 3.582 MB / 0.5137 GB
Notification: Performance of FrontEnd - DAE generated: time 5.12e-06/0.6406, allocations: 0 / 0.6976 GB, free: 3.582 MB / 0.5137 GB
Notification: Performance of FrontEnd: time 4.308e-06/0.6406, allocations: 0 / 0.6976 GB, free: 3.582 MB / 0.5137 GB
Notification: Performance of Transformations before backend: time 0.0001034/0.6407, allocations: 3.938 kB / 0.6976 GB, free: 3.578 MB / 0.5137 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 327
 * Number of variables: 327
Notification: Performance of Generate backend data structure: time 0.006111/0.6468, allocations: 2.501 MB / 0.7 GB, free: 2.008 MB / 0.5137 GB
Notification: Performance of prepare preOptimizeDAE: time 4.235e-05/0.6469, allocations: 9.219 kB / 0.7 GB, free: 2.008 MB / 0.5137 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002411/0.6493, allocations: 457.2 kB / 0.7005 GB, free: 1.852 MB / 0.5137 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004918/0.6542, allocations: 2.154 MB / 0.7026 GB, free: 284 kB / 0.5137 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000125/0.6544, allocations: 114.7 kB / 0.7027 GB, free: 228 kB / 0.5137 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003535/0.6547, allocations: 141.5 kB / 0.7028 GB, free: 184 kB / 0.5137 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003504/0.6582, allocations: 1.54 MB / 0.7043 GB, free: 15.21 MB / 0.5294 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.63e-05/0.6583, allocations: 9.453 kB / 0.7043 GB, free: 15.2 MB / 0.5294 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000159/0.6585, allocations: 55.69 kB / 0.7044 GB, free: 15.16 MB / 0.5294 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.377e-05/0.6585, allocations: 47.52 kB / 0.7044 GB, free: 15.16 MB / 0.5294 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002622/0.6612, allocations: 1.172 MB / 0.7056 GB, free: 14.57 MB / 0.5294 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.01115/0.6723, allocations: 7.67 MB / 0.7131 GB, free: 7.777 MB / 0.5294 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002199/0.6746, allocations: 0.9739 MB / 0.714 GB, free: 7.254 MB / 0.5294 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001061/0.6756, allocations: 0.5471 MB / 0.7146 GB, free: 6.992 MB / 0.5294 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 evalFunc (simulation): time 0.004363/0.68, allocations: 2.52 MB / 0.717 GB, free: 4.734 MB / 0.5294 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.036e-05/0.6801, allocations: 52.2 kB / 0.7171 GB, free: 4.68 MB / 0.5294 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001197/0.6813, allocations: 231.3 kB / 0.7173 GB, free: 4.562 MB / 0.5294 GB
Notification: Performance of pre-optimization done (n=85): time 5.139e-06/0.6813, allocations: 0 / 0.7173 GB, free: 4.562 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=85): time 0.006537/0.6878, allocations: 2.054 MB / 0.7193 GB, free: 3.492 MB / 0.5294 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.036e-05/0.6879, allocations: 65.81 kB / 0.7194 GB, free: 3.422 MB / 0.5294 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003357/0.6913, allocations: 1.787 MB / 0.7211 GB, free: 2.441 MB / 0.5294 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002267/0.6915, allocations: 48.98 kB / 0.7212 GB, free: 2.395 MB / 0.5294 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0009488/0.6925, allocations: 0.9967 MB / 0.7221 GB, free: 1.512 MB / 0.5294 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004427/0.6929, allocations: 303.7 kB / 0.7224 GB, free: 1.25 MB / 0.5294 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001789/0.6931, allocations: 98.62 kB / 0.7225 GB, free: 1.184 MB / 0.5294 GB
Notification: Performance of setup shared object (initialization): time 0.0001293/0.6933, allocations: 351.6 kB / 0.7228 GB, free: 0.8438 MB / 0.5294 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001009/0.6943, allocations: 497.4 kB / 0.7233 GB, free: 0.5039 MB / 0.5294 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001357/0.6957, allocations: 0.8991 MB / 0.7242 GB, free: 15.43 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002384/0.698, allocations: 1.342 MB / 0.7255 GB, free: 13.96 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.604e-05/0.6981, allocations: 8 kB / 0.7255 GB, free: 13.95 MB / 0.545 GB
Notification: Performance of matching and sorting (n=141) (initialization): time 0.004374/0.7025, allocations: 1.683 MB / 0.7272 GB, free: 12.25 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0004043/0.7029, allocations: 372.7 kB / 0.7275 GB, free: 11.76 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.954e-05/0.7029, allocations: 8 kB / 0.7275 GB, free: 11.75 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001253/0.7042, allocations: 332.5 kB / 0.7278 GB, free: 11.43 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001011/0.7052, allocations: 251.7 kB / 0.7281 GB, free: 11.18 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001128/0.7064, allocations: 0.8628 MB / 0.7289 GB, free: 10.29 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001979/0.7084, allocations: 123.8 kB / 0.729 GB, free: 10.17 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001631/0.7085, allocations: 67.97 kB / 0.7291 GB, free: 10.11 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 1.237e-05/0.7085, allocations: 4 kB / 0.7291 GB, free: 10.1 MB / 0.545 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002976/0.7115, allocations: 1.402 MB / 0.7305 GB, free: 8.691 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.25e-05/0.7116, allocations: 8 kB / 0.7305 GB, free: 8.684 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001186/0.7128, allocations: 329 kB / 0.7308 GB, free: 8.359 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009023/0.7137, allocations: 243.6 kB / 0.731 GB, free: 8.121 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007733/0.7214, allocations: 4.235 MB / 0.7352 GB, free: 3.672 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001885/0.7233, allocations: 115.8 kB / 0.7353 GB, free: 3.559 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001959/0.7235, allocations: 59.98 kB / 0.7353 GB, free: 3.5 MB / 0.545 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 41
 * 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 (120):
 * Single equations (assignments): 117
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * 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): 1 system
   {(2,18)}
Notification: Performance of prepare postOptimizeDAE: time 0.001382/0.7249, allocations: 0.5474 MB / 0.7359 GB, free: 2.941 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006427/0.7256, allocations: 201.5 kB / 0.7361 GB, free: 2.742 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003651/0.7292, allocations: 1.569 MB / 0.7376 GB, free: 1.164 MB / 0.545 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.84e-05/0.7293, allocations: 12 kB / 0.7376 GB, free: 1.152 MB / 0.545 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.807e-06/0.7293, allocations: 0 / 0.7376 GB, free: 1.152 MB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002424/0.7317, allocations: 1.223 MB / 0.7388 GB, free: 15.89 MB / 0.5606 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.006427/0.7381, allocations: 3.29 MB / 0.742 GB, free: 12.5 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.751e-06/0.7382, allocations: 0 / 0.742 GB, free: 12.5 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008286/0.739, allocations: 167.8 kB / 0.7422 GB, free: 12.33 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0006204/0.7396, allocations: 216.6 kB / 0.7424 GB, free: 12.12 MB / 0.5606 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.754e-05/0.7397, allocations: 31.97 kB / 0.7424 GB, free: 12.09 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0008517/0.7406, allocations: 0.8174 MB / 0.7432 GB, free: 11.24 MB / 0.5606 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.515e-05/0.7406, allocations: 4.031 kB / 0.7432 GB, free: 11.24 MB / 0.5606 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004018/0.7447, allocations: 2.017 MB / 0.7452 GB, free: 9.195 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001214/0.7459, allocations: 398.3 kB / 0.7456 GB, free: 8.785 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006037/0.7465, allocations: 20 kB / 0.7456 GB, free: 8.766 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001555/0.7481, allocations: 114.5 kB / 0.7457 GB, free: 8.656 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001308/0.7482, allocations: 64.89 kB / 0.7457 GB, free: 8.59 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001003/0.7483, allocations: 47.91 kB / 0.7458 GB, free: 8.543 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.002586/0.7509, allocations: 1.205 MB / 0.747 GB, free: 7.32 MB / 0.5606 GB
Notification: Performance of sort global known variables: time 2.21e-07/0.7509, allocations: 0 / 0.747 GB, free: 7.32 MB / 0.5606 GB
Notification: Performance of remove unused functions: time 0.005704/0.7566, allocations: 1.189 MB / 0.7481 GB, free: 6.129 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 6 (floMac1.vol.dynBal.U,floMac1.filter.s[1],floMac1.filter.s[2],floMac2.vol.dynBal.U,floMac2.filter.s[1],floMac2.filter.s[2])
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (84):
 * Single equations (assignments): 78
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 5
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * 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): 1 system
   {(2,19)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.00271/0.7594, allocations: 0.6189 MB / 0.7487 GB, free: 5.512 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.006687/0.7661, allocations: 2.082 MB / 0.7508 GB, free: 3.422 MB / 0.5606 GB
Notification: Performance of simCode: created event and clocks part: time 1.028e-05/0.7661, allocations: 4 kB / 0.7508 GB, free: 3.418 MB / 0.5606 GB
Notification: Performance of simCode: created simulation system equations: time 0.001918/0.768, allocations: 0.5528 MB / 0.7513 GB, free: 2.871 MB / 0.5606 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.008688/0.7767, allocations: 0.9417 MB / 0.7522 GB, free: 1.949 MB / 0.5606 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01156/0.7883, allocations: 4.437 MB / 0.7566 GB, free: 13.48 MB / 0.5762 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002274/0.7907, allocations: 1.548 MB / 0.7581 GB, free: 11.89 MB / 0.5762 GB
Notification: Performance of simCode: alias equations: time 0.003914/0.7946, allocations: 477 kB / 0.7585 GB, free: 11.43 MB / 0.5762 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0008419/0.7955, allocations: 175.4 kB / 0.7587 GB, free: 11.25 MB / 0.5762 GB
Notification: Performance of SimCode: time 3.035e-06/0.7955, allocations: 0 / 0.7587 GB, free: 11.25 MB / 0.5762 GB
Notification: Performance of Templates: time 0.08953/0.8851, allocations: 43.6 MB / 0.8013 GB, free: 100 kB / 0.6075 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpsParallel.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpsParallel.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpsParallel.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpsParallel.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpsParallel.sim & ./IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpsParallel  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpsParallel.pipe 2>&1)