Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_8.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/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 8.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo)
Running command: translateModel(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource")
translateModel(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo): time 1.597/1.597, allocations: 287.5 MB / 302.6 MB, free: 8.223 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.00108/0.00108, allocations: 177.6 kB / 371.2 MB, free: 10.82 MB / 298.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.66/1.66, allocations: 205.4 MB / 0.6298 GB, free: 10.59 MB / 458.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0009002/0.0009002, allocations: 101.6 kB / 0.7432 GB, free: 6.559 MB / 0.5573 GB
Notification: Performance of FrontEnd - loaded program: time 0.0003965/0.0003967, allocations: 11.97 kB / 0.8661 GB, free: 140.8 MB / 0.6198 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.207/0.2074, allocations: 115.3 MB / 0.9787 GB, free: 28.2 MB / 0.6198 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource): time 0.8176/1.025, allocations: 278.7 MB / 1.251 GB, free: 5.051 MB / 0.7761 GB
Notification: Performance of NFInst.instExpressions: time 0.03391/1.059, allocations: 23.98 MB / 1.274 GB, free: 13.04 MB / 0.8073 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004886/1.064, allocations: 99.31 kB / 1.274 GB, free: 12.94 MB / 0.8073 GB
Notification: Performance of NFTyping.typeComponents: time 0.004817/1.069, allocations: 1.196 MB / 1.276 GB, free: 11.74 MB / 0.8073 GB
Notification: Performance of NFTyping.typeBindings: time 0.01503/1.084, allocations: 4.359 MB / 1.28 GB, free: 7.363 MB / 0.8073 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007946/1.092, allocations: 1.945 MB / 1.282 GB, free: 5.438 MB / 0.8073 GB
Notification: Performance of NFFlatten.flatten: time 0.01444/1.106, allocations: 10.44 MB / 1.292 GB, free: 10.97 MB / 0.823 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.005124/1.111, allocations: 2.933 MB / 1.295 GB, free: 7.969 MB / 0.823 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007943/1.119, allocations: 3.194 MB / 1.298 GB, free: 4.762 MB / 0.823 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.005414/1.125, allocations: 2.822 MB / 1.301 GB, free: 1.93 MB / 0.823 GB
Notification: Performance of NFPackage.collectConstants: time 0.0009855/1.126, allocations: 152 kB / 1.301 GB, free: 1.781 MB / 0.823 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.008734/1.135, allocations: 2.412 MB / 1.303 GB, free: 15.36 MB / 0.8386 GB
Notification: Performance of NFScalarize.scalarize: time 0.003081/1.138, allocations: 1.418 MB / 1.305 GB, free: 13.94 MB / 0.8386 GB
Notification: Performance of NFVerifyModel.verify: time 0.002256/1.14, allocations: 0.7616 MB / 1.305 GB, free: 13.17 MB / 0.8386 GB
Notification: Performance of NFConvertDAE.convert: time 0.008018/1.148, allocations: 4.731 MB / 1.31 GB, free: 8.43 MB / 0.8386 GB
Notification: Performance of FrontEnd - DAE generated: time 6.752e-06/1.148, allocations: 0 / 1.31 GB, free: 8.43 MB / 0.8386 GB
Notification: Performance of FrontEnd: time 1.933e-06/1.148, allocations: 4 kB / 1.31 GB, free: 8.426 MB / 0.8386 GB
Notification: Performance of Transformations before backend: time 0.0001414/1.148, allocations: 0 / 1.31 GB, free: 8.426 MB / 0.8386 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 693
 * Number of variables: 693
Notification: Performance of Generate backend data structure: time 0.006262/1.155, allocations: 3.432 MB / 1.313 GB, free: 4.926 MB / 0.8386 GB
Notification: Performance of prepare preOptimizeDAE: time 4.168e-05/1.155, allocations: 12.03 kB / 1.313 GB, free: 4.914 MB / 0.8386 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005135/1.16, allocations: 0.9322 MB / 1.314 GB, free: 3.977 MB / 0.8386 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004914/1.165, allocations: 2.451 MB / 1.317 GB, free: 1.449 MB / 0.8386 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002693/1.165, allocations: 285.3 kB / 1.317 GB, free: 1.156 MB / 0.8386 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004433/1.165, allocations: 295.9 kB / 1.317 GB, free: 0.8672 MB / 0.8386 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005881/1.171, allocations: 3.343 MB / 1.32 GB, free: 13.44 MB / 0.8542 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.329e-05/1.171, allocations: 4 kB / 1.32 GB, free: 13.43 MB / 0.8542 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000242/1.172, allocations: 112 kB / 1.32 GB, free: 13.32 MB / 0.8542 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000119/1.172, allocations: 113.3 kB / 1.321 GB, free: 13.21 MB / 0.8542 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004547/1.176, allocations: 2.781 MB / 1.323 GB, free: 10.42 MB / 0.8542 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.01779/1.194, allocations: 13.26 MB / 1.336 GB, free: 11.97 MB / 0.8698 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002973/1.197, allocations: 1.86 MB / 1.338 GB, free: 10.11 MB / 0.8698 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001667/1.199, allocations: 1.125 MB / 1.339 GB, free: 8.984 MB / 0.8698 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005254/1.199, allocations: 325.2 kB / 1.339 GB, free: 8.609 MB / 0.8698 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.372e-05/1.199, allocations: 60.5 kB / 1.34 GB, free: 8.543 MB / 0.8698 GB
Notification: Performance of pre-optimization done (n=186): time 5.33e-06/1.199, allocations: 0 / 1.34 GB, free: 8.543 MB / 0.8698 GB
Notification: Performance of matching and sorting (n=186): time 0.005696/1.205, allocations: 2.774 MB / 1.342 GB, free: 5.766 MB / 0.8698 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.149e-05/1.205, allocations: 73.53 kB / 1.342 GB, free: 5.68 MB / 0.8698 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003479/1.209, allocations: 1.961 MB / 1.344 GB, free: 3.699 MB / 0.8698 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004134/1.209, allocations: 77.64 kB / 1.344 GB, free: 3.617 MB / 0.8698 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001225/1.21, allocations: 1.395 MB / 1.346 GB, free: 2.207 MB / 0.8698 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0008048/1.211, allocations: 0.6507 MB / 1.346 GB, free: 1.547 MB / 0.8698 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 9.211e-05/1.211, allocations: 40 kB / 1.346 GB, free: 1.508 MB / 0.8698 GB
Notification: Performance of setup shared object (initialization): time 0.0002298/1.212, allocations: 386 kB / 1.347 GB, free: 1.125 MB / 0.8698 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001421/1.213, allocations: 0.8004 MB / 1.347 GB, free: 328 kB / 0.8698 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001858/1.215, allocations: 1.462 MB / 1.349 GB, free: 14.58 MB / 0.8855 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003213/1.218, allocations: 2.238 MB / 1.351 GB, free: 12.16 MB / 0.8855 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.055e-05/1.218, allocations: 4 kB / 1.351 GB, free: 12.16 MB / 0.8855 GB
Notification: Performance of matching and sorting (n=261) (initialization): time 0.004456/1.223, allocations: 2.487 MB / 1.354 GB, free: 9.664 MB / 0.8855 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003684/1.223, allocations: 482.1 kB / 1.354 GB, free: 9.02 MB / 0.8855 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.732e-05/1.223, allocations: 12 kB / 1.354 GB, free: 9.008 MB / 0.8855 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.583e-05/1.223, allocations: 24 kB / 1.354 GB, free: 8.984 MB / 0.8855 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002549/1.226, allocations: 0.5656 MB / 1.355 GB, free: 8.418 MB / 0.8855 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002488/1.228, allocations: 4.157 MB / 1.359 GB, free: 4.098 MB / 0.8855 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003428/1.232, allocations: 379.1 kB / 1.359 GB, free: 3.727 MB / 0.8855 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001742/1.232, allocations: 87.98 kB / 1.359 GB, free: 3.641 MB / 0.8855 GB
Notification: Performance of prepare postOptimizeDAE: time 1.151e-05/1.232, allocations: 4 kB / 1.359 GB, free: 3.637 MB / 0.8855 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.003429/1.235, allocations: 2.23 MB / 1.361 GB, free: 1.406 MB / 0.8855 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.831e-05/1.235, allocations: 12.16 kB / 1.361 GB, free: 1.395 MB / 0.8855 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.466e-05/1.235, allocations: 24 kB / 1.361 GB, free: 1.371 MB / 0.8855 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001766/1.237, allocations: 479.3 kB / 1.362 GB, free: 0.9023 MB / 0.8855 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.199e-05/1.237, allocations: 31.92 kB / 1.362 GB, free: 0.8711 MB / 0.8855 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003378/1.241, allocations: 361.4 kB / 1.362 GB, free: 0.5195 MB / 0.8855 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000147/1.241, allocations: 87.98 kB / 1.362 GB, free: 444 kB / 0.8855 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.001938/1.243, allocations: 0.8672 MB / 1.363 GB, free: 15.55 MB / 0.9011 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006529/1.243, allocations: 268.8 kB / 1.363 GB, free: 15.29 MB / 0.9011 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003513/1.247, allocations: 2.138 MB / 1.365 GB, free: 13.14 MB / 0.9011 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.62e-05/1.247, allocations: 16 kB / 1.365 GB, free: 13.12 MB / 0.9011 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.881e-06/1.247, allocations: 0 / 1.365 GB, free: 13.12 MB / 0.9011 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002575/1.249, allocations: 1.91 MB / 1.367 GB, free: 11.16 MB / 0.9011 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00868/1.258, allocations: 5.208 MB / 1.372 GB, free: 5.852 MB / 0.9011 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.318e-06/1.258, allocations: 4 kB / 1.372 GB, free: 5.848 MB / 0.9011 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002342/1.261, allocations: 0.5114 MB / 1.373 GB, free: 5.336 MB / 0.9011 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.815e-05/1.261, allocations: 8 kB / 1.373 GB, free: 5.328 MB / 0.9011 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001293/1.261, allocations: 55.92 kB / 1.373 GB, free: 5.273 MB / 0.9011 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001962/1.263, allocations: 4.13 MB / 1.377 GB, free: 0.9805 MB / 0.9011 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.559e-06/1.263, allocations: 4 kB / 1.377 GB, free: 0.9766 MB / 0.9011 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005206/1.268, allocations: 3.41 MB / 1.38 GB, free: 13.51 MB / 0.9167 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001554/1.269, allocations: 0.5755 MB / 1.381 GB, free: 12.91 MB / 0.9167 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000378/1.27, allocations: 51.98 kB / 1.381 GB, free: 12.86 MB / 0.9167 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002138/1.272, allocations: 240.3 kB / 1.381 GB, free: 12.62 MB / 0.9167 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002201/1.272, allocations: 117.8 kB / 1.381 GB, free: 12.51 MB / 0.9167 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001289/1.272, allocations: 75.95 kB / 1.381 GB, free: 12.44 MB / 0.9167 GB
Notification: Performance of sorting global known variables: time 0.001924/1.274, allocations: 1.298 MB / 1.383 GB, free: 11.13 MB / 0.9167 GB
Notification: Performance of sort global known variables: time 1.61e-07/1.274, allocations: 0 / 1.383 GB, free: 11.13 MB / 0.9167 GB
Notification: Performance of remove unused functions: time 0.004306/1.279, allocations: 1.726 MB / 1.384 GB, free: 9.398 MB / 0.9167 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 13
 * Number of states: 20 (vol.dynBal.U,vol.dynBal.m,vol.dynBal.mXi[1],vol.dynBal.mC[1],vol1.dynBal.U,vol1.dynBal.m,vol1.dynBal.mXi[1],vol1.dynBal.mC[1],vol2.dynBal.U,vol2.dynBal.m,vol2.dynBal.mXi[1],vol2.dynBal.mC[1],vol3.dynBal.U,vol3.dynBal.m,vol3.dynBal.mXi[1],vol3.dynBal.mC[1],vol4.dynBal.U,vol4.dynBal.m,vol4.dynBal.mXi[1],vol4.dynBal.mC[1])
 * 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 (186):
 * Single equations (assignments): 179
 * 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 Backend phase and start with SimCode phase: time 0.000735/1.279, allocations: 382.1 kB / 1.385 GB, free: 9.035 MB / 0.9167 GB
Notification: Performance of simCode: created initialization part: time 0.00612/1.286, allocations: 3.352 MB / 1.388 GB, free: 5.691 MB / 0.9167 GB
Notification: Performance of simCode: created event and clocks part: time 8.596e-06/1.286, allocations: 4 kB / 1.388 GB, free: 5.688 MB / 0.9167 GB
Notification: Performance of simCode: created simulation system equations: time 0.001712/1.287, allocations: 1.044 MB / 1.389 GB, free: 4.645 MB / 0.9167 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.008742/1.296, allocations: 1.579 MB / 1.39 GB, free: 3.07 MB / 0.9167 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01103/1.307, allocations: 7.868 MB / 1.398 GB, free: 11.13 MB / 0.9323 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001882/1.309, allocations: 2.178 MB / 1.4 GB, free: 8.922 MB / 0.9323 GB
Notification: Performance of simCode: alias equations: time 0.003963/1.313, allocations: 1.107 MB / 1.401 GB, free: 7.809 MB / 0.9323 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006296/1.314, allocations: 231.3 kB / 1.402 GB, free: 7.582 MB / 0.9323 GB
Notification: Performance of SimCode: time 6.81e-07/1.314, allocations: 0 / 1.402 GB, free: 7.582 MB / 0.9323 GB
Notification: Performance of Templates: time 0.5136/1.827, allocations: 52.34 MB / 1.453 GB, free: 338.5 MB / 0.948 GB
make -j1 -f Buildings_8.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.makefile
(rm -f Buildings_8.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe ; mkfifo Buildings_8.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe ; head -c 1048576 < Buildings_8.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe >> ../files/Buildings_8.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.sim & ./Buildings_8.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_8.0.0_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe 2>&1)