Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Fluid.Examples.Performance.Example1v2.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 Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 9.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo)
Running command: translateModel(Buildings.Fluid.Examples.Performance.Example1v2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Fluid.Examples.Performance.Example1v2")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 4.462/4.462, allocations: 0.5623 GB / 0.5775 GB, free: 66.95 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002598/0.002598, allocations: 355.6 kB / 0.6446 GB, free: 21.6 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.068/4.068, allocations: 410.8 MB / 1.113 GB, free: 15.72 MB / 0.6198 GB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001852/0.001851, allocations: 178.8 kB / 1.226 GB, free: 11.67 MB / 0.7292 GB
Notification: Performance of FrontEnd - loaded program: time 0.0006488/0.0006491, allocations: 12.55 kB / 1.349 GB, free: 320.5 MB / 0.8073 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1965/0.1972, allocations: 115.3 MB / 1.461 GB, free: 220.7 MB / 0.8073 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.Performance.Example1v2): time 0.08708/0.2843, allocations: 74.47 MB / 1.534 GB, free: 146.2 MB / 0.8073 GB
Notification: Performance of NFInst.instExpressions: time 0.0368/0.3211, allocations: 20.75 MB / 1.554 GB, free: 125.5 MB / 0.8073 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00381/0.325, allocations: 91.31 kB / 1.554 GB, free: 125.4 MB / 0.8073 GB
Notification: Performance of NFTyping.typeComponents: time 0.004964/0.33, allocations: 1.134 MB / 1.556 GB, free: 124.2 MB / 0.8073 GB
Notification: Performance of NFTyping.typeBindings: time 0.01233/0.3424, allocations: 3.313 MB / 1.559 GB, free: 120.9 MB / 0.8073 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01469/0.3571, allocations: 3.931 MB / 1.563 GB, free: 117 MB / 0.8073 GB
Notification: Performance of NFFlatten.flatten: time 0.03296/0.3901, allocations: 30.02 MB / 1.592 GB, free: 86.94 MB / 0.8073 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0221/0.4122, allocations: 12.94 MB / 1.605 GB, free: 73.93 MB / 0.8073 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01685/0.4291, allocations: 8.915 MB / 1.613 GB, free: 64.98 MB / 0.8073 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02385/0.453, allocations: 10.74 MB / 1.624 GB, free: 54.2 MB / 0.8073 GB
Notification: Performance of NFPackage.collectConstants: time 0.004697/0.4578, allocations: 0.8164 MB / 1.625 GB, free: 53.39 MB / 0.8073 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.009904/0.4677, allocations: 1.772 MB / 1.626 GB, free: 51.61 MB / 0.8073 GB
Notification: Performance of NFScalarize.scalarize: time 0.006506/0.4743, allocations: 2.963 MB / 1.629 GB, free: 48.64 MB / 0.8073 GB
Notification: Performance of NFVerifyModel.verify: time 0.005187/0.4795, allocations: 1.833 MB / 1.631 GB, free: 46.8 MB / 0.8073 GB
Notification: Performance of NFConvertDAE.convert: time 0.01905/0.4986, allocations: 13.89 MB / 1.645 GB, free: 32.88 MB / 0.8073 GB
Notification: Performance of FrontEnd - DAE generated: time 6.973e-06/0.4987, allocations: 3.938 kB / 1.645 GB, free: 32.87 MB / 0.8073 GB
Notification: Performance of FrontEnd: time 2.645e-06/0.4987, allocations: 0 / 1.645 GB, free: 32.87 MB / 0.8073 GB
Notification: Performance of Transformations before backend: time 0.0004634/0.4991, allocations: 0 / 1.645 GB, free: 32.87 MB / 0.8073 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1418
 * Number of variables: 1418
Notification: Performance of Generate backend data structure: time 0.05158/0.5507, allocations: 13.07 MB / 1.657 GB, free: 19.7 MB / 0.8073 GB
Notification: Performance of prepare preOptimizeDAE: time 5.116e-05/0.5508, allocations: 13.11 kB / 1.657 GB, free: 19.68 MB / 0.8073 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009701/0.5605, allocations: 1.269 MB / 1.659 GB, free: 18.4 MB / 0.8073 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02827/0.5888, allocations: 9.616 MB / 1.668 GB, free: 8.707 MB / 0.8073 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000525/0.5894, allocations: 448 kB / 1.668 GB, free: 8.266 MB / 0.8073 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003719/0.5932, allocations: 0.5779 MB / 1.669 GB, free: 7.688 MB / 0.8073 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 1.238/1.831, allocations: 14.68 MB / 1.683 GB, free: 196.6 MB / 0.8074 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003326/1.831, allocations: 21.31 kB / 1.683 GB, free: 196.6 MB / 0.8074 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003328/1.834, allocations: 240.1 kB / 1.683 GB, free: 196.4 MB / 0.8074 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001988/1.835, allocations: 138.9 kB / 1.684 GB, free: 196.4 MB / 0.8074 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05144/1.886, allocations: 19.89 MB / 1.703 GB, free: 189.7 MB / 0.8074 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.1649/2.051, allocations: 66.61 MB / 1.768 GB, free: 132.9 MB / 0.8074 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0205/2.072, allocations: 9.314 MB / 1.777 GB, free: 123.6 MB / 0.8074 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01787/2.09, allocations: 8.677 MB / 1.786 GB, free: 114.9 MB / 0.8074 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0896/2.179, allocations: 30.99 MB / 1.816 GB, free: 83.73 MB / 0.8074 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01794/2.197, allocations: 7.748 MB / 1.823 GB, free: 75.94 MB / 0.8074 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.05192/2.249, allocations: 11.77 MB / 1.835 GB, free: 64.3 MB / 0.8074 GB
Notification: Performance of pre-optimization done (n=300): time 2.677e-05/2.249, allocations: 0 / 1.835 GB, free: 64.3 MB / 0.8074 GB
Notification: Performance of matching and sorting (n=300): time 0.0887/2.338, allocations: 24.44 MB / 1.859 GB, free: 39.73 MB / 0.8074 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.602e-05/2.338, allocations: 85.77 kB / 1.859 GB, free: 39.63 MB / 0.8074 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01848/2.357, allocations: 8.1 MB / 1.867 GB, free: 31.54 MB / 0.8074 GB
Notification: Performance of collectPreVariables (initialization): time 0.002396/2.359, allocations: 101.7 kB / 1.867 GB, free: 31.44 MB / 0.8074 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005372/2.364, allocations: 4.017 MB / 1.871 GB, free: 27.41 MB / 0.8074 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003541/2.368, allocations: 1.077 MB / 1.872 GB, free: 26.34 MB / 0.8074 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002324/2.37, allocations: 88 kB / 1.872 GB, free: 26.25 MB / 0.8074 GB
Notification: Performance of setup shared object (initialization): time 0.0003999/2.371, allocations: 499.8 kB / 1.872 GB, free: 25.76 MB / 0.8074 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01555/2.386, allocations: 6.543 MB / 1.879 GB, free: 19.2 MB / 0.8074 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01723/2.404, allocations: 8.4 MB / 1.887 GB, free: 9.957 MB / 0.8074 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01791/2.422, allocations: 7.446 MB / 1.894 GB, free: 2.488 MB / 0.8074 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.602e-05/2.422, allocations: 16 kB / 1.894 GB, free: 2.473 MB / 0.8074 GB
Notification: Performance of matching and sorting (n=579) (initialization): time 0.06404/2.486, allocations: 17.8 MB / 1.912 GB, free: 0.6133 MB / 0.823 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001394/2.487, allocations: 1.56 MB / 1.913 GB, free: 14.37 MB / 0.8387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001198/2.487, allocations: 48 kB / 1.913 GB, free: 14.32 MB / 0.8387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.1441/2.632, allocations: 11.5 MB / 1.925 GB, free: 2.859 MB / 0.8387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0167/2.648, allocations: 1.567 MB / 1.926 GB, free: 1.289 MB / 0.8387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01766/2.666, allocations: 6.802 MB / 1.933 GB, free: 10.27 MB / 0.8543 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0193/2.685, allocations: 0.5931 MB / 1.933 GB, free: 9.676 MB / 0.8543 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003478/2.689, allocations: 0.5421 MB / 1.934 GB, free: 9.133 MB / 0.8543 GB
Notification: Performance of prepare postOptimizeDAE: time 1.757e-05/2.689, allocations: 4 kB / 1.934 GB, free: 9.129 MB / 0.8543 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.05765/2.747, allocations: 16.74 MB / 1.95 GB, free: 8.34 MB / 0.8699 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001323/2.747, allocations: 48 kB / 1.95 GB, free: 8.293 MB / 0.8699 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.1396/2.886, allocations: 11.03 MB / 1.961 GB, free: 13.29 MB / 0.8855 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01639/2.903, allocations: 1.557 MB / 1.963 GB, free: 11.73 MB / 0.8855 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02623/2.929, allocations: 11.02 MB / 1.973 GB, free: 276 kB / 0.8855 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01838/2.948, allocations: 0.5621 MB / 1.974 GB, free: 15.71 MB / 0.9012 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003357/2.951, allocations: 0.5382 MB / 1.974 GB, free: 15.17 MB / 0.9012 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 217
 * Number of states: 0 ()
 * Number of discrete variables: 8 ($whenCondition1,$PRE.pulse.T_start,pulse.T_start,$PRE.pulse.count,pulse.count,from_dp.y,nRes.y,allowFlowReversal.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (527):
 * Single equations (assignments): 521
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(1,100.0%) 1}
 * Non-linear torn systems: 3 {1 3,20 21,2 5}
Notification: Performance of prepare postOptimizeDAE: time 0.01024/2.961, allocations: 2.631 MB / 1.977 GB, free: 12.52 MB / 0.9012 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004774/2.966, allocations: 0.7563 MB / 1.978 GB, free: 11.76 MB / 0.9012 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05271/3.019, allocations: 14.36 MB / 1.992 GB, free: 13.37 MB / 0.9168 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.03237/3.051, allocations: 10.93 MB / 2.002 GB, free: 2.348 MB / 0.9168 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.992e-05/3.051, allocations: 0 / 2.002 GB, free: 2.348 MB / 0.9168 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008282/3.06, allocations: 2.002 MB / 2.004 GB, free: 324 kB / 0.9168 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003639/3.063, allocations: 71.98 kB / 2.004 GB, free: 252 kB / 0.9168 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01308/3.076, allocations: 446.8 kB / 2.005 GB, free: 15.81 MB / 0.9324 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001995/3.078, allocations: 250.4 kB / 2.005 GB, free: 15.56 MB / 0.9324 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.04313/3.122, allocations: 12.03 MB / 2.017 GB, free: 3.559 MB / 0.9324 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.6838/3.806, allocations: 19.54 MB / 2.036 GB, free: 316.2 MB / 0.948 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01371/3.819, allocations: 6.075 MB / 2.042 GB, free: 315.3 MB / 0.948 GB
Notification: Performance of sorting global known variables: time 0.01421/3.834, allocations: 5.569 MB / 2.047 GB, free: 313.6 MB / 0.948 GB
Notification: Performance of Backend: time 1.072e-06/3.834, allocations: 0 / 2.047 GB, free: 313.6 MB / 0.948 GB
Notification: Performance of simCode: created initialization part: time 0.06013/3.894, allocations: 19.8 MB / 2.067 GB, free: 305.8 MB / 0.948 GB
Notification: Performance of SimCode: time 0.06899/3.963, allocations: 23.24 MB / 2.089 GB, free: 296.2 MB / 0.948 GB
Notification: Performance of Templates: time 0.518/4.481, allocations: 260.3 MB / 2.343 GB, free: 49.43 MB / 0.948 GB