Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_7.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.1/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 7.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.1/package.mo)
Running command: translateModel(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_7.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource")
translateModel(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_7.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.1/package.mo): time 2.298/2.298, allocations: 251.1 MB / 266.7 MB, free: 11.64 MB / 218.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001293/0.001293, allocations: 171.5 kB / 326.3 MB, free: 2.875 MB / 250.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.379/2.379, allocations: 205.4 MB / 0.5772 GB, free: 20.74 MB / 426.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0009568/0.0009565, allocations: 91.55 kB / 0.6817 GB, free: 13.63 MB / 0.5105 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004702/0.0004704, allocations: 14.5 kB / 0.7957 GB, free: 135.5 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2048/0.2053, allocations: 106.3 MB / 0.8995 GB, free: 65.52 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource): time 1.144/1.349, allocations: 279.4 MB / 1.172 GB, free: 14.61 MB / 0.7136 GB
Notification: Performance of NFInst.instExpressions: time 0.04946/1.398, allocations: 24.21 MB / 1.196 GB, free: 15.68 MB / 0.7292 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004935/1.403, allocations: 93.06 kB / 1.196 GB, free: 15.68 MB / 0.7292 GB
Notification: Performance of NFTyping.typeComponents: time 0.006029/1.409, allocations: 1.204 MB / 1.197 GB, free: 15.03 MB / 0.7292 GB
Notification: Performance of NFTyping.typeBindings: time 0.01821/1.428, allocations: 4.402 MB / 1.202 GB, free: 11.59 MB / 0.7292 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009344/1.437, allocations: 2.015 MB / 1.204 GB, free: 10.18 MB / 0.7292 GB
Notification: Performance of NFFlatten.flatten: time 0.01929/1.456, allocations: 10.73 MB / 1.214 GB, free: 2.414 MB / 0.7292 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.006932/1.463, allocations: 2.681 MB / 1.217 GB, free: 15.68 MB / 0.7448 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01122/1.475, allocations: 3.28 MB / 1.22 GB, free: 12.39 MB / 0.7448 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.007492/1.482, allocations: 2.865 MB / 1.223 GB, free: 9.512 MB / 0.7448 GB
Notification: Performance of NFPackage.collectConstants: time 0.001259/1.483, allocations: 152 kB / 1.223 GB, free: 9.363 MB / 0.7448 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01105/1.495, allocations: 2.412 MB / 1.225 GB, free: 6.945 MB / 0.7448 GB
Notification: Performance of NFScalarize.scalarize: time 0.003437/1.498, allocations: 1.453 MB / 1.227 GB, free: 5.488 MB / 0.7448 GB
Notification: Performance of NFVerifyModel.verify: time 0.002376/1.5, allocations: 0.7732 MB / 1.227 GB, free: 4.707 MB / 0.7448 GB
Notification: Performance of NFConvertDAE.convert: time 0.011/1.511, allocations: 4.825 MB / 1.232 GB, free: 15.87 MB / 0.7605 GB
Notification: Performance of FrontEnd - DAE generated: time 7.343e-06/1.512, allocations: 0 / 1.232 GB, free: 15.87 MB / 0.7605 GB
Notification: Performance of FrontEnd: time 2.434e-06/1.512, allocations: 3.938 kB / 1.232 GB, free: 15.86 MB / 0.7605 GB
Notification: Performance of Transformations before backend: time 0.0001646/1.512, allocations: 0 / 1.232 GB, free: 15.86 MB / 0.7605 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 703
 * Number of variables: 703
Notification: Performance of Generate backend data structure: time 0.01012/1.522, allocations: 3.496 MB / 1.235 GB, free: 12.3 MB / 0.7605 GB
Notification: Performance of prepare preOptimizeDAE: time 5.088e-05/1.522, allocations: 8.031 kB / 1.235 GB, free: 12.3 MB / 0.7605 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008446/1.53, allocations: 0.9399 MB / 1.236 GB, free: 11.35 MB / 0.7605 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.007941/1.538, allocations: 2.363 MB / 1.239 GB, free: 8.914 MB / 0.7605 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004124/1.539, allocations: 285.5 kB / 1.239 GB, free: 8.621 MB / 0.7605 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0008921/1.54, allocations: 299.9 kB / 1.239 GB, free: 8.328 MB / 0.7605 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.009994/1.55, allocations: 3.384 MB / 1.243 GB, free: 4.859 MB / 0.7605 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001064/1.55, allocations: 7.938 kB / 1.243 GB, free: 4.852 MB / 0.7605 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004837/1.55, allocations: 116 kB / 1.243 GB, free: 4.738 MB / 0.7605 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000196/1.551, allocations: 117.4 kB / 1.243 GB, free: 4.621 MB / 0.7605 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.009058/1.56, allocations: 2.804 MB / 1.245 GB, free: 1.805 MB / 0.7605 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.02697/1.587, allocations: 13.3 MB / 1.258 GB, free: 3.312 MB / 0.7761 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004621/1.591, allocations: 1.837 MB / 1.26 GB, free: 1.473 MB / 0.7761 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002766/1.594, allocations: 1.106 MB / 1.261 GB, free: 376 kB / 0.7761 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007489/1.595, allocations: 333.3 kB / 1.262 GB, free: 15.98 MB / 0.7917 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.759e-05/1.595, allocations: 68.48 kB / 1.262 GB, free: 15.91 MB / 0.7917 GB
Notification: Performance of pre-optimization done (n=186): time 4.809e-06/1.595, allocations: 0 / 1.262 GB, free: 15.91 MB / 0.7917 GB
Notification: Performance of matching and sorting (n=186): time 0.008403/1.603, allocations: 2.738 MB / 1.264 GB, free: 13.16 MB / 0.7917 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.611e-05/1.604, allocations: 73.41 kB / 1.264 GB, free: 13.08 MB / 0.7917 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004182/1.608, allocations: 1.965 MB / 1.266 GB, free: 11.09 MB / 0.7917 GB
Notification: Performance of collectPreVariables (initialization): time 0.000509/1.608, allocations: 73.7 kB / 1.266 GB, free: 11.02 MB / 0.7917 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001636/1.61, allocations: 1.399 MB / 1.268 GB, free: 9.602 MB / 0.7917 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001199/1.611, allocations: 0.6584 MB / 1.268 GB, free: 8.934 MB / 0.7917 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001761/1.611, allocations: 40 kB / 1.269 GB, free: 8.895 MB / 0.7917 GB
Notification: Performance of setup shared object (initialization): time 0.0002378/1.612, allocations: 394 kB / 1.269 GB, free: 8.504 MB / 0.7917 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002359/1.614, allocations: 0.7848 MB / 1.27 GB, free: 7.715 MB / 0.7917 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003191/1.617, allocations: 1.432 MB / 1.271 GB, free: 6.016 MB / 0.7917 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003074/1.62, allocations: 1.052 MB / 1.272 GB, free: 4.965 MB / 0.7917 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.521e-05/1.62, allocations: 3.938 kB / 1.272 GB, free: 4.961 MB / 0.7917 GB
Notification: Performance of matching and sorting (n=261) (initialization): time 0.007174/1.628, allocations: 2.462 MB / 1.274 GB, free: 2.488 MB / 0.7917 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0004414/1.628, allocations: 482.8 kB / 1.275 GB, free: 1.84 MB / 0.7917 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.658e-05/1.628, allocations: 16 kB / 1.275 GB, free: 1.824 MB / 0.7917 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.961e-05/1.628, allocations: 20 kB / 1.275 GB, free: 1.805 MB / 0.7917 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005219/1.633, allocations: 0.5578 MB / 1.276 GB, free: 1.246 MB / 0.7917 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003009/1.636, allocations: 4.165 MB / 1.28 GB, free: 12.92 MB / 0.8073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005523/1.642, allocations: 381 kB / 1.28 GB, free: 12.55 MB / 0.8073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002955/1.642, allocations: 91.97 kB / 1.28 GB, free: 12.46 MB / 0.8073 GB
Notification: Performance of prepare postOptimizeDAE: time 1.346e-05/1.642, allocations: 0 / 1.28 GB, free: 12.46 MB / 0.8073 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.006099/1.648, allocations: 2.206 MB / 1.282 GB, free: 10.25 MB / 0.8073 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.448e-05/1.649, allocations: 15.98 kB / 1.282 GB, free: 10.23 MB / 0.8073 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.085e-05/1.649, allocations: 28.09 kB / 1.282 GB, free: 10.21 MB / 0.8073 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003645/1.652, allocations: 475.3 kB / 1.283 GB, free: 9.742 MB / 0.8073 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 5.416e-05/1.652, allocations: 31.92 kB / 1.283 GB, free: 9.711 MB / 0.8073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005163/1.657, allocations: 365 kB / 1.283 GB, free: 9.355 MB / 0.8073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002729/1.658, allocations: 87.98 kB / 1.283 GB, free: 9.27 MB / 0.8073 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 56
 * 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 (261):
 * Single equations (assignments): 254
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 7
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 7 {1,1,1,1,1,1,1}
 * Without analytic Jacobian: 0
Notification: Performance of prepare postOptimizeDAE: time 0.002342/1.66, allocations: 0.8754 MB / 1.284 GB, free: 8.383 MB / 0.8073 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008646/1.661, allocations: 268.8 kB / 1.284 GB, free: 8.117 MB / 0.8073 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005659/1.667, allocations: 2.13 MB / 1.286 GB, free: 5.973 MB / 0.8073 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004514/1.671, allocations: 1.89 MB / 1.288 GB, free: 4.035 MB / 0.8073 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.006e-05/1.671, allocations: 0 / 1.288 GB, free: 4.035 MB / 0.8073 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002206/1.673, allocations: 0.5872 MB / 1.289 GB, free: 3.426 MB / 0.8073 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006022/1.674, allocations: 43.98 kB / 1.289 GB, free: 3.383 MB / 0.8073 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004385/1.679, allocations: 267 kB / 1.289 GB, free: 3.121 MB / 0.8073 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003398/1.679, allocations: 105.8 kB / 1.289 GB, free: 3.02 MB / 0.8073 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.008837/1.688, allocations: 2.374 MB / 1.291 GB, free: 0.6172 MB / 0.8073 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.008478/1.696, allocations: 3.439 MB / 1.295 GB, free: 13.16 MB / 0.823 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002188/1.698, allocations: 0.9096 MB / 1.296 GB, free: 12.25 MB / 0.823 GB
Notification: Performance of sorting global known variables: time 0.002962/1.701, allocations: 1.31 MB / 1.297 GB, free: 10.93 MB / 0.823 GB
Notification: Performance of Backend: time 9.92e-07/1.701, allocations: 4 kB / 1.297 GB, free: 10.92 MB / 0.823 GB
Notification: Performance of simCode: created initialization part: time 0.01276/1.714, allocations: 3.522 MB / 1.3 GB, free: 7.422 MB / 0.823 GB
Notification: Performance of SimCode: time 0.02462/1.739, allocations: 8.866 MB / 1.309 GB, free: 14.5 MB / 0.8386 GB
Notification: Performance of Templates: time 0.1778/1.917, allocations: 65.59 MB / 1.373 GB, free: 13.32 MB / 0.9011 GB
make -j1 -f Buildings_7.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.makefile
(rm -f Buildings_7.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe ; mkfifo Buildings_7.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe ; head -c 1048576 < Buildings_7.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe >> ../files/Buildings_7.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.sim & ./Buildings_7.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_7.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe 2>&1)