Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.Movers.Examples.PumpsParallel.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.Movers.Examples.PumpsParallel,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.Movers.Examples.PumpsParallel")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002553/0.002553, allocations: 358.7 kB / 16.59 MB, free: 5.566 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.438/1.438, allocations: 165.8 MB / 183.1 MB, free: 5.492 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.885/3.885, allocations: 410.7 MB / 0.6001 GB, free: 15.14 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.001741/0.001741, allocations: 191.1 kB / 0.6668 GB, free: 6.895 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004588/0.000459, allocations: 12 kB / 0.7429 GB, free: 8.938 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.39/0.3904, allocations: 67.45 MB / 0.8087 GB, free: 28.76 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Movers.Examples.PumpsParallel): time 0.0828/0.4733, allocations: 61.95 MB / 0.8692 GB, free: 14.65 MB / 426.7 MB
Notification: Performance of NFInst.instExpressions: time 0.04273/0.5161, allocations: 20.58 MB / 0.8893 GB, free: 10.03 MB / 442.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003415/0.5195, allocations: 79.44 kB / 0.8894 GB, free: 9.949 MB / 442.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.004766/0.5244, allocations: 0.9822 MB / 0.8904 GB, free: 8.961 MB / 442.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01276/0.5372, allocations: 3.134 MB / 0.8934 GB, free: 5.816 MB / 442.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01309/0.5503, allocations: 3.241 MB / 0.8966 GB, free: 2.605 MB / 442.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01239/0.5627, allocations: 6.981 MB / 0.9034 GB, free: 11.6 MB / 458.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003763/0.5665, allocations: 1.614 MB / 0.905 GB, free: 9.969 MB / 458.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005508/0.572, allocations: 1.929 MB / 0.9069 GB, free: 8.031 MB / 458.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004032/0.5761, allocations: 1.684 MB / 0.9085 GB, free: 6.34 MB / 458.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0005109/0.5766, allocations: 92 kB / 0.9086 GB, free: 6.25 MB / 458.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.004606/0.5813, allocations: 1.212 MB / 0.9098 GB, free: 5.035 MB / 458.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001093/0.5824, allocations: 0.5642 MB / 0.9103 GB, free: 4.469 MB / 458.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001105/0.5835, allocations: 0.5043 MB / 0.9108 GB, free: 3.957 MB / 458.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.005959/0.5895, allocations: 3.063 MB / 0.9138 GB, free: 0.8867 MB / 458.7 MB
Notification: Performance of FrontEnd - DAE generated: time 8.716e-06/0.5895, allocations: 0 / 0.9138 GB, free: 0.8867 MB / 458.7 MB
Notification: Performance of FrontEnd: time 1.894e-06/0.5895, allocations: 3.938 kB / 0.9138 GB, free: 0.8828 MB / 458.7 MB
Notification: Performance of Transformations before backend: time 4.918e-05/0.5896, allocations: 0 / 0.9138 GB, free: 0.8828 MB / 458.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 329
 * Number of variables: 329
Notification: Performance of Generate backend data structure: time 0.007074/0.5967, allocations: 2.563 MB / 0.9163 GB, free: 14.26 MB / 474.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.807e-05/0.5967, allocations: 12.03 kB / 0.9163 GB, free: 14.25 MB / 474.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003403/0.6002, allocations: 460.4 kB / 0.9168 GB, free: 13.79 MB / 474.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006354/0.6065, allocations: 2.064 MB / 0.9188 GB, free: 11.66 MB / 474.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000139/0.6067, allocations: 115 kB / 0.9189 GB, free: 11.54 MB / 474.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003656/0.6071, allocations: 148 kB / 0.919 GB, free: 11.4 MB / 474.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004376/0.6115, allocations: 1.587 MB / 0.9206 GB, free: 9.727 MB / 474.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 5.233e-05/0.6115, allocations: 3.906 kB / 0.9206 GB, free: 9.723 MB / 474.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002176/0.6118, allocations: 59.95 kB / 0.9207 GB, free: 9.664 MB / 474.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.74e-05/0.6118, allocations: 32 kB / 0.9207 GB, free: 9.633 MB / 474.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003957/0.6158, allocations: 1.157 MB / 0.9218 GB, free: 8.469 MB / 474.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.01478/0.6306, allocations: 7.671 MB / 0.9293 GB, free: 212 kB / 474.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.3819/1.013, allocations: 0.9676 MB / 0.9303 GB, free: 113.5 MB / 474.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001733/1.014, allocations: 0.5455 MB / 0.9308 GB, free: 113.5 MB / 474.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 evalFunc (simulation): time 0.005682/1.02, allocations: 2.518 MB / 0.9332 GB, free: 111.7 MB / 474.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.795e-05/1.02, allocations: 44.59 kB / 0.9333 GB, free: 111.7 MB / 474.7 MB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001588/1.022, allocations: 231.8 kB / 0.9335 GB, free: 111.7 MB / 474.7 MB
Notification: Performance of pre-optimization done (n=84): time 4.088e-06/1.022, allocations: 0 / 0.9335 GB, free: 111.7 MB / 474.7 MB
Notification: Performance of matching and sorting (n=84): time 0.0106/1.032, allocations: 1.979 MB / 0.9354 GB, free: 111.1 MB / 474.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.661e-05/1.032, allocations: 216.2 kB / 0.9356 GB, free: 110.9 MB / 474.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003309/1.036, allocations: 1.813 MB / 0.9374 GB, free: 110.2 MB / 474.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0002544/1.036, allocations: 49.64 kB / 0.9375 GB, free: 110.1 MB / 474.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.000938/1.037, allocations: 1.02 MB / 0.9385 GB, free: 109.4 MB / 474.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003325/1.037, allocations: 298.5 kB / 0.9387 GB, free: 109.2 MB / 474.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001039/1.037, allocations: 24.19 kB / 0.9388 GB, free: 109.2 MB / 474.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001036/1.038, allocations: 357 kB / 0.9391 GB, free: 108.8 MB / 474.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001524/1.039, allocations: 442 kB / 0.9395 GB, free: 108.7 MB / 474.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001789/1.041, allocations: 0.8931 MB / 0.9404 GB, free: 108 MB / 474.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001736/1.043, allocations: 0.5526 MB / 0.9409 GB, free: 107.8 MB / 474.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.759e-06/1.043, allocations: 6.812 kB / 0.9409 GB, free: 107.8 MB / 474.7 MB
Notification: Performance of matching and sorting (n=149) (initialization): time 0.005195/1.048, allocations: 1.561 MB / 0.9425 GB, free: 107.1 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001861/1.048, allocations: 373.3 kB / 0.9428 GB, free: 106.7 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.2e-05/1.048, allocations: 11.39 kB / 0.9428 GB, free: 106.7 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001871/1.05, allocations: 267.6 kB / 0.9431 GB, free: 106.6 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001812/1.052, allocations: 253 kB / 0.9433 GB, free: 106.6 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001102/1.053, allocations: 0.852 MB / 0.9442 GB, free: 106 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002378/1.055, allocations: 122.6 kB / 0.9443 GB, free: 105.9 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000215/1.056, allocations: 76.92 kB / 0.9444 GB, free: 105.9 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 9.628e-06/1.056, allocations: 3.969 kB / 0.9444 GB, free: 105.9 MB / 474.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.00436/1.06, allocations: 1.468 MB / 0.9458 GB, free: 105.4 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.749e-05/1.06, allocations: 17.2 kB / 0.9458 GB, free: 105.4 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001937/1.062, allocations: 325.8 kB / 0.9461 GB, free: 105.3 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001559/1.064, allocations: 238.1 kB / 0.9463 GB, free: 105.2 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01018/1.074, allocations: 4.216 MB / 0.9505 GB, free: 102.2 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002321/1.076, allocations: 114 kB / 0.9506 GB, free: 102.2 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000164/1.076, allocations: 70.5 kB / 0.9506 GB, free: 102.1 MB / 474.7 MB
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 (124):
 * Single equations (assignments): 117
 * Array equations: 4
 * Algorithm blocks: 0
 * Record equations: 2
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {2 18}
Notification: Performance of prepare postOptimizeDAE: time 0.001213/1.078, allocations: 0.5587 MB / 0.9512 GB, free: 101.7 MB / 474.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003508/1.078, allocations: 207.4 kB / 0.9514 GB, free: 101.6 MB / 474.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004753/1.083, allocations: 1.561 MB / 0.9529 GB, free: 100.5 MB / 474.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003358/1.086, allocations: 1.218 MB / 0.9541 GB, free: 99.28 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.314e-06/1.086, allocations: 3.984 kB / 0.9541 GB, free: 99.27 MB / 474.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008458/1.087, allocations: 401.2 kB / 0.9545 GB, free: 98.86 MB / 474.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003316/1.087, allocations: 20 kB / 0.9545 GB, free: 98.84 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001822/1.089, allocations: 102.4 kB / 0.9546 GB, free: 98.75 MB / 474.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001742/1.089, allocations: 84.86 kB / 0.9547 GB, free: 98.66 MB / 474.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.004745/1.094, allocations: 1.338 MB / 0.956 GB, free: 97.34 MB / 474.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.004491/1.099, allocations: 1.858 MB / 0.9578 GB, free: 95.46 MB / 474.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001273/1.1, allocations: 463.7 kB / 0.9582 GB, free: 95.01 MB / 474.7 MB
Notification: Performance of sorting global known variables: time 0.002197/1.102, allocations: 1.207 MB / 0.9594 GB, free: 93.79 MB / 474.7 MB
Notification: Performance of Backend: time 9.71e-07/1.102, allocations: 3.938 kB / 0.9594 GB, free: 93.79 MB / 474.7 MB
Notification: Performance of simCode: created initialization part: time 0.00778/1.11, allocations: 2.505 MB / 0.9619 GB, free: 91.38 MB / 474.7 MB
Notification: Performance of SimCode: time 0.01168/1.122, allocations: 5.526 MB / 0.9673 GB, free: 85.83 MB / 474.7 MB
Notification: Performance of Templates: time 0.1026/1.224, allocations: 46.85 MB / 1.013 GB, free: 39.34 MB / 474.7 MB