Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.MixingVolumes.Examples.MixingVolumeHeatConduction.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.MixingVolumes.Examples.MixingVolumeHeatConduction,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.MixingVolumes.Examples.MixingVolumeHeatConduction")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002546/0.002551, allocations: 358 kB / 16.59 MB, free: 5.562 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.593/1.593, allocations: 165.8 MB / 183.1 MB, free: 5.457 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.804/3.804, allocations: 410.8 MB / 0.6001 GB, free: 15.18 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.001748/0.001747, allocations: 195.6 kB / 0.6668 GB, free: 6.941 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004734/0.0004736, allocations: 12 kB / 0.7429 GB, free: 8.992 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4067/0.4072, allocations: 67.45 MB / 0.8087 GB, free: 28.8 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.MixingVolumes.Examples.MixingVolumeHeatConduction): time 0.6994/1.107, allocations: 154.2 MB / 0.9593 GB, free: 1.438 MB / 474.7 MB
Notification: Performance of NFInst.instExpressions: time 0.008758/1.115, allocations: 4.355 MB / 0.9636 GB, free: 1.371 MB / 474.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001033/1.116, allocations: 17.97 kB / 0.9636 GB, free: 1.371 MB / 474.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.00131/1.118, allocations: 281.9 kB / 0.9639 GB, free: 1.371 MB / 474.7 MB
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:788:36-789:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:786:36-787:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:734:36-735:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:732:36-733:54:writable] Warning: 'each' used when modifying non-array element m_flow.
Notification: Performance of NFTyping.typeBindings: time 0.004628/1.122, allocations: 1.071 MB / 0.9649 GB, free: 1.359 MB / 474.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003459/1.126, allocations: 0.7633 MB / 0.9657 GB, free: 1.34 MB / 474.7 MB
Notification: Performance of NFFlatten.flatten: time 0.003568/1.13, allocations: 1.975 MB / 0.9676 GB, free: 1.188 MB / 474.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009519/1.131, allocations: 425.7 kB / 0.968 GB, free: 1.125 MB / 474.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001685/1.132, allocations: 0.5648 MB / 0.9686 GB, free: 0.9922 MB / 474.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001284/1.134, allocations: 0.5253 MB / 0.9691 GB, free: 0.9062 MB / 474.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001485/1.134, allocations: 26 kB / 0.9691 GB, free: 0.9062 MB / 474.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001567/1.135, allocations: 319.3 kB / 0.9694 GB, free: 0.8711 MB / 474.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0003544/1.136, allocations: 227.3 kB / 0.9696 GB, free: 0.8477 MB / 474.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0003537/1.136, allocations: 171.8 kB / 0.9698 GB, free: 0.793 MB / 474.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.001466/1.138, allocations: 0.8425 MB / 0.9706 GB, free: 0.7305 MB / 474.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.811e-06/1.138, allocations: 0 / 0.9706 GB, free: 0.7305 MB / 474.7 MB
Notification: Performance of FrontEnd: time 2.465e-06/1.138, allocations: 0 / 0.9706 GB, free: 0.7305 MB / 474.7 MB
Notification: Performance of Transformations before backend: time 1.628e-05/1.138, allocations: 0 / 0.9706 GB, free: 0.7305 MB / 474.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 136
 * Number of variables: 136
Notification: Performance of Generate backend data structure: time 0.002662/1.14, allocations: 0.8931 MB / 0.9715 GB, free: 156 kB / 474.7 MB
Notification: Performance of prepare preOptimizeDAE: time 6.548e-05/1.14, allocations: 9.344 kB / 0.9715 GB, free: 156 kB / 474.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00263/1.143, allocations: 162.7 kB / 0.9716 GB, free: 116 kB / 474.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002203/1.145, allocations: 0.5017 MB / 0.9721 GB, free: 15.85 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.759e-05/1.145, allocations: 49.12 kB / 0.9722 GB, free: 15.84 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001651/1.146, allocations: 53.8 kB / 0.9722 GB, free: 15.84 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002955/1.149, allocations: 0.656 MB / 0.9729 GB, free: 15.75 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.138e-05/1.149, allocations: 2.5 kB / 0.9729 GB, free: 15.75 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001261/1.149, allocations: 23.97 kB / 0.9729 GB, free: 15.75 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.046e-05/1.149, allocations: 23.66 kB / 0.9729 GB, free: 15.75 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002423/1.151, allocations: 0.5185 MB / 0.9734 GB, free: 15.75 MB / 490.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.005652/1.157, allocations: 2.305 MB / 0.9757 GB, free: 14.54 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0008085/1.158, allocations: 260.5 kB / 0.9759 GB, free: 14.48 MB / 490.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.000434/1.158, allocations: 134.7 kB / 0.9761 GB, free: 14.45 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 4.838e-05/1.158, allocations: 13.41 kB / 0.9761 GB, free: 14.45 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.508e-05/1.158, allocations: 43.91 kB / 0.9761 GB, free: 14.4 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=20): time 2.996e-06/1.158, allocations: 0 / 0.9761 GB, free: 14.4 MB / 490.7 MB
Notification: Performance of matching and sorting (n=20): time 0.002729/1.161, allocations: 0.6877 MB / 0.9768 GB, free: 14.04 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.084e-05/1.161, allocations: 80.08 kB / 0.9769 GB, free: 13.94 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0009852/1.162, allocations: 0.5492 MB / 0.9774 GB, free: 13.73 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 6.884e-05/1.162, allocations: 33.14 kB / 0.9774 GB, free: 13.7 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002951/1.163, allocations: 327.2 kB / 0.9777 GB, free: 13.5 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001004/1.163, allocations: 76.84 kB / 0.9778 GB, free: 13.45 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 2.677e-05/1.163, allocations: 7.25 kB / 0.9778 GB, free: 13.45 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 0.000161/1.163, allocations: 358.3 kB / 0.9782 GB, free: 13.12 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000422/1.163, allocations: 137.3 kB / 0.9783 GB, free: 13.1 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004987/1.164, allocations: 229.4 kB / 0.9785 GB, free: 12.97 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0004921/1.164, allocations: 169.1 kB / 0.9787 GB, free: 12.94 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.109e-06/1.164, allocations: 3.125 kB / 0.9787 GB, free: 12.94 MB / 490.7 MB
Notification: Performance of matching and sorting (n=40) (initialization): time 0.00153/1.166, allocations: 0.4986 MB / 0.9792 GB, free: 12.79 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.374e-05/1.166, allocations: 6.312 kB / 0.9792 GB, free: 12.79 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.879e-06/1.166, allocations: 2.562 kB / 0.9792 GB, free: 12.79 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0004565/1.167, allocations: 94.25 kB / 0.9793 GB, free: 12.75 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006198/1.167, allocations: 76.42 kB / 0.9793 GB, free: 12.73 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003982/1.171, allocations: 3.1 MB / 0.9824 GB, free: 10.02 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009963/1.172, allocations: 65.73 kB / 0.9824 GB, free: 9.98 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.103e-05/1.172, allocations: 13.94 kB / 0.9824 GB, free: 9.98 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 10
 * 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 (34):
 * Single equations (assignments): 32
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 5,1 1}
Notification: Performance of prepare postOptimizeDAE: time 0.000436/1.173, allocations: 224.3 kB / 0.9826 GB, free: 9.84 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001343/1.173, allocations: 52.91 kB / 0.9827 GB, free: 9.816 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0001244/1.173, allocations: 56.17 kB / 0.9828 GB, free: 9.797 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001132/1.174, allocations: 0.5402 MB / 0.9833 GB, free: 9.391 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.576e-06/1.174, allocations: 0 / 0.9833 GB, free: 9.391 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003435/1.174, allocations: 167.5 kB / 0.9834 GB, free: 9.254 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001163/1.175, allocations: 6.125 kB / 0.9834 GB, free: 9.254 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008141/1.175, allocations: 40.11 kB / 0.9835 GB, free: 9.234 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.105e-05/1.176, allocations: 14.08 kB / 0.9835 GB, free: 9.227 MB / 490.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001523/1.177, allocations: 444.3 kB / 0.9839 GB, free: 9.035 MB / 490.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.001344/1.178, allocations: 0.5985 MB / 0.9845 GB, free: 8.734 MB / 490.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0003438/1.179, allocations: 112 kB / 0.9846 GB, free: 8.711 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.0006805/1.179, allocations: 394.1 kB / 0.985 GB, free: 8.57 MB / 490.7 MB
Notification: Performance of Backend: time 1.032e-06/1.18, allocations: 0 / 0.985 GB, free: 8.57 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.002221/1.182, allocations: 0.6653 MB / 0.9856 GB, free: 8.18 MB / 490.7 MB
Notification: Performance of SimCode: time 0.004649/1.186, allocations: 1.914 MB / 0.9875 GB, free: 6.879 MB / 490.7 MB
Notification: Performance of Templates: time 0.03484/1.221, allocations: 12.85 MB / 1 GB, free: 492 kB / 490.7 MB