Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo", uses=false) Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo) Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo) Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo) Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo) Running command: translateModel(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|C.C|C1.C|vol4.C.1.|C2.C|C3.C",fileNamePrefix="Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource") translateModel(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|C.C|C1.C|vol4.C.1.|C2.C|C3.C",fileNamePrefix="Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001491/0.001491, allocations: 98.03 kB / 15.36 MB, free: 0.7344 MB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.01047/0.01047, allocations: 168.9 kB / 16.26 MB, free: 6.648 MB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.422/1.422, allocations: 223.3 MB / 240.3 MB, free: 5.355 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.868/2.868, allocations: 462.7 MB / 0.7364 GB, free: 280 kB / 0.5762 GB Notification: Performance of FrontEnd - loaded program: time 0.0005026/0.0005024, allocations: 8.844 kB / 0.9028 GB, free: 36.7 MB / 0.7169 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3256/0.3262, allocations: 159.6 MB / 1.059 GB, free: 5.469 MB / 0.8106 GB Notification: Performance of NFInst.instantiate(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource): time 0.9287/1.255, allocations: 298.8 MB / 1.35 GB, free: 1.57 MB / 0.9981 GB Notification: Performance of NFInst.instExpressions: time 0.03342/1.288, allocations: 25.74 MB / 1.376 GB, free: 0.918 MB / 0.9981 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.006092/1.294, allocations: 112.1 kB / 1.376 GB, free: 0.918 MB / 0.9981 GB Notification: Performance of NFTyping.typeComponents: time 0.006144/1.301, allocations: 1.542 MB / 1.377 GB, free: 0.8828 MB / 0.9981 GB Notification: Performance of NFTyping.typeBindings: time 0.01805/1.319, allocations: 5.621 MB / 1.383 GB, free: 0.5898 MB / 0.9981 GB Notification: Performance of NFTyping.typeClassSections: time 0.007374/1.326, allocations: 2.383 MB / 1.385 GB, free: 0 / 0.9981 GB Notification: Performance of NFFlatten.flatten: time 0.01793/1.344, allocations: 12.49 MB / 1.397 GB, free: 11.61 MB / 1.014 GB Notification: Performance of NFFlatten.resolveConnections: time 0.005486/1.35, allocations: 2.985 MB / 1.4 GB, free: 9.973 MB / 1.014 GB Notification: Performance of NFEvalConstants.evaluate: time 0.013/1.363, allocations: 3.542 MB / 1.404 GB, free: 8.27 MB / 1.014 GB Notification: Performance of NFSimplifyModel.simplify: time 0.007549/1.37, allocations: 2.938 MB / 1.406 GB, free: 6.922 MB / 1.014 GB Notification: Performance of NFPackage.collectConstants: time 0.0009194/1.371, allocations: 152.7 kB / 1.407 GB, free: 6.922 MB / 1.014 GB Notification: Performance of NFFlatten.collectFunctions: time 0.01238/1.384, allocations: 5.28 MB / 1.412 GB, free: 4.488 MB / 1.014 GB Notification: Performance of NFScalarize.scalarize: time 0.002828/1.386, allocations: 1.426 MB / 1.413 GB, free: 3.633 MB / 1.014 GB Notification: Performance of NFVerifyModel.verify: time 0.004452/1.391, allocations: 1.883 MB / 1.415 GB, free: 2.508 MB / 1.014 GB Notification: Performance of NFConvertDAE.convert: time 0.01561/1.407, allocations: 6.739 MB / 1.422 GB, free: 14.57 MB / 1.029 GB Notification: Performance of FrontEnd - DAE generated: time 6.822e-06/1.407, allocations: 0 / 1.422 GB, free: 14.57 MB / 1.029 GB Notification: Performance of FrontEnd: time 3.005e-06/1.407, allocations: 0 / 1.422 GB, free: 14.57 MB / 1.029 GB Notification: Performance of Transformations before backend: time 0.0002331/1.407, allocations: 0 / 1.422 GB, free: 14.57 MB / 1.029 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.01201/1.419, allocations: 3.438 MB / 1.425 GB, free: 11.61 MB / 1.029 GB Notification: Performance of prepare preOptimizeDAE: time 4.558e-05/1.419, allocations: 8.031 kB / 1.425 GB, free: 11.6 MB / 1.029 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006297/1.425, allocations: 0.9434 MB / 1.426 GB, free: 10.66 MB / 1.029 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.004699/1.43, allocations: 2.258 MB / 1.428 GB, free: 8.375 MB / 1.029 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00025/1.43, allocations: 277.3 kB / 1.428 GB, free: 8.09 MB / 1.029 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.000471/1.431, allocations: 295.7 kB / 1.429 GB, free: 7.805 MB / 1.029 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.00561/1.436, allocations: 3.366 MB / 1.432 GB, free: 4.355 MB / 1.029 GB Notification: Performance of preOpt findStateOrder (simulation): time 5.727e-05/1.436, allocations: 4 kB / 1.432 GB, free: 4.352 MB / 1.029 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002491/1.437, allocations: 115.8 kB / 1.432 GB, free: 4.242 MB / 1.029 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001111/1.437, allocations: 113.3 kB / 1.432 GB, free: 4.129 MB / 1.029 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004465/1.441, allocations: 2.8 MB / 1.435 GB, free: 1.316 MB / 1.029 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.01698/1.458, allocations: 13.26 MB / 1.448 GB, free: 2.996 MB / 1.045 GB Notification: Performance of preOpt comSubExp (simulation): time 0.002557/1.461, allocations: 1.693 MB / 1.449 GB, free: 1.297 MB / 1.045 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001608/1.462, allocations: 1.106 MB / 1.451 GB, free: 200 kB / 1.045 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0004945/1.463, allocations: 331.5 kB / 1.451 GB, free: 15.82 MB / 1.061 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.153e-05/1.463, allocations: 52.56 kB / 1.451 GB, free: 15.77 MB / 1.061 GB Notification: Performance of pre-optimization done (n=182): time 3.456e-06/1.463, allocations: 4 kB / 1.451 GB, free: 15.76 MB / 1.061 GB Notification: Performance of matching and sorting (n=182): time 0.005176/1.468, allocations: 2.735 MB / 1.454 GB, free: 13.02 MB / 1.061 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.816e-05/1.468, allocations: 73.41 kB / 1.454 GB, free: 12.94 MB / 1.061 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002952/1.471, allocations: 1.998 MB / 1.456 GB, free: 10.92 MB / 1.061 GB Notification: Performance of collectPreVariables (initialization): time 0.000302/1.472, allocations: 69.64 kB / 1.456 GB, free: 10.85 MB / 1.061 GB Notification: Performance of collectInitialEqns (initialization): time 0.001032/1.473, allocations: 1.407 MB / 1.457 GB, free: 9.43 MB / 1.061 GB Notification: Performance of collectInitialBindings (initialization): time 0.0006981/1.473, allocations: 0.6472 MB / 1.458 GB, free: 8.789 MB / 1.061 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002336/1.474, allocations: 173.6 kB / 1.458 GB, free: 8.613 MB / 1.061 GB Notification: Performance of setup shared object (initialization): time 9.153e-05/1.474, allocations: 309 kB / 1.458 GB, free: 8.309 MB / 1.061 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001272/1.475, allocations: 0.8043 MB / 1.459 GB, free: 7.5 MB / 1.061 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001685/1.477, allocations: 1.41 MB / 1.46 GB, free: 5.832 MB / 1.061 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.003265/1.48, allocations: 2.26 MB / 1.462 GB, free: 3.391 MB / 1.061 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.267e-05/1.48, allocations: 8 kB / 1.462 GB, free: 3.383 MB / 1.061 GB Notification: Performance of matching and sorting (n=257) (initialization): time 0.004387/1.484, allocations: 2.497 MB / 1.465 GB, free: 0.875 MB / 1.061 GB Notification: Performance of prepare postOptimizeDAE: time 0.0003697/1.485, allocations: 0.4885 MB / 1.465 GB, free: 212 kB / 1.061 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.286e-05/1.485, allocations: 16 kB / 1.465 GB, free: 196 kB / 1.061 GB Notification: Performance of postOpt tearingSystem (initialization): time 3.463e-05/1.485, allocations: 20 kB / 1.465 GB, free: 176 kB / 1.061 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002588/1.487, allocations: 0.5539 MB / 1.466 GB, free: 15.62 MB / 1.076 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002231/1.49, allocations: 4.161 MB / 1.47 GB, free: 11.29 MB / 1.076 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003729/1.493, allocations: 393.9 kB / 1.47 GB, free: 10.91 MB / 1.076 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002036/1.494, allocations: 87.98 kB / 1.47 GB, free: 10.82 MB / 1.076 GB Notification: Performance of prepare postOptimizeDAE: time 1.287e-05/1.494, allocations: 4 kB / 1.47 GB, free: 10.82 MB / 1.076 GB Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.003473/1.497, allocations: 2.226 MB / 1.473 GB, free: 8.59 MB / 1.076 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.862e-05/1.497, allocations: 16 kB / 1.473 GB, free: 8.574 MB / 1.076 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.254e-05/1.497, allocations: 28.09 kB / 1.473 GB, free: 8.547 MB / 1.076 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00169/1.499, allocations: 479.3 kB / 1.473 GB, free: 8.078 MB / 1.076 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.074e-05/1.499, allocations: 31.88 kB / 1.473 GB, free: 8.047 MB / 1.076 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003668/1.503, allocations: 378 kB / 1.474 GB, free: 7.676 MB / 1.076 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001886/1.503, allocations: 87.98 kB / 1.474 GB, free: 7.59 MB / 1.076 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 59 * 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 (257): * Single equations (assignments): 250 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 7 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 0 systems * Non-linear Jacobian (size): 7 systems {1, 1, 1, 1, 1, 1, 1} * Without analytic Jacobian (size): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.00187/1.505, allocations: 0.8557 MB / 1.474 GB, free: 6.723 MB / 1.076 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007143/1.505, allocations: 272.7 kB / 1.475 GB, free: 6.453 MB / 1.076 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003504/1.509, allocations: 2.111 MB / 1.477 GB, free: 4.324 MB / 1.076 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.469e-05/1.509, allocations: 23.94 kB / 1.477 GB, free: 4.301 MB / 1.076 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 7.203e-06/1.509, allocations: 0 / 1.477 GB, free: 4.301 MB / 1.076 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002542/1.512, allocations: 1.89 MB / 1.479 GB, free: 2.363 MB / 1.076 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.008407/1.52, allocations: 5.187 MB / 1.484 GB, free: 13.12 MB / 1.092 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.003e-06/1.52, allocations: 4 kB / 1.484 GB, free: 13.11 MB / 1.092 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002319/1.522, allocations: 499.8 kB / 1.484 GB, free: 12.62 MB / 1.092 GB Notification: Performance of postOpt tearingSystem (simulation): time 1.811e-05/1.522, allocations: 11.98 kB / 1.484 GB, free: 12.61 MB / 1.092 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001269/1.522, allocations: 51.98 kB / 1.484 GB, free: 12.56 MB / 1.092 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001908/1.524, allocations: 4.126 MB / 1.488 GB, free: 8.273 MB / 1.092 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.4e-06/1.524, allocations: 3.938 kB / 1.488 GB, free: 8.27 MB / 1.092 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004714/1.529, allocations: 3.242 MB / 1.491 GB, free: 4.973 MB / 1.092 GB Notification: Performance of postOpt removeConstants (simulation): time 0.00142/1.531, allocations: 0.5677 MB / 1.492 GB, free: 4.383 MB / 1.092 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003297/1.531, allocations: 43.98 kB / 1.492 GB, free: 4.34 MB / 1.092 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002364/1.533, allocations: 256.1 kB / 1.492 GB, free: 4.09 MB / 1.092 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002275/1.533, allocations: 113.7 kB / 1.492 GB, free: 3.98 MB / 1.092 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001275/1.534, allocations: 71.97 kB / 1.492 GB, free: 3.91 MB / 1.092 GB Notification: Performance of sorting global known variables: time 0.001898/1.536, allocations: 1.334 MB / 1.494 GB, free: 2.566 MB / 1.092 GB Notification: Performance of sort global known variables: time 3.71e-07/1.536, allocations: 0 / 1.494 GB, free: 2.566 MB / 1.092 GB Notification: Performance of remove unused functions: time 0.004398/1.54, allocations: 1.71 MB / 1.495 GB, free: 0.8516 MB / 1.092 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 13 * Number of states: 20 (vol.dynBal.medium.Xi[1],vol.dynBal.U,vol.dynBal.m,vol.dynBal.mC[1],vol1.dynBal.medium.Xi[1],vol1.dynBal.U,vol1.dynBal.m,vol1.dynBal.mC[1],vol2.dynBal.medium.Xi[1],vol2.dynBal.U,vol2.dynBal.m,vol2.dynBal.mC[1],vol3.dynBal.medium.Xi[1],vol3.dynBal.U,vol3.dynBal.m,vol3.dynBal.mC[1],vol4.dynBal.medium.Xi[1],vol4.dynBal.U,vol4.dynBal.m,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 (182): * Single equations (assignments): 175 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 7 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 0 systems * Non-linear Jacobian (size): 7 systems {1, 1, 1, 1, 1, 1, 1} * Without analytic Jacobian (size): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.0008903/1.541, allocations: 362.3 kB / 1.496 GB, free: 0.5078 MB / 1.092 GB Notification: Performance of simCode: created initialization part: time 0.006102/1.547, allocations: 3.318 MB / 1.499 GB, free: 13.2 MB / 1.107 GB Notification: Performance of simCode: created event and clocks part: time 9.297e-06/1.547, allocations: 0 / 1.499 GB, free: 13.2 MB / 1.107 GB Notification: Performance of simCode: created simulation system equations: time 0.00177/1.549, allocations: 1.039 MB / 1.5 GB, free: 12.16 MB / 1.107 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.009853/1.559, allocations: 1.587 MB / 1.502 GB, free: 10.58 MB / 1.107 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01188/1.571, allocations: 8.161 MB / 1.51 GB, free: 2.355 MB / 1.107 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001914/1.573, allocations: 2.186 MB / 1.512 GB, free: 140 kB / 1.107 GB Notification: Performance of simCode: alias equations: time 0.004897/1.577, allocations: 1.096 MB / 1.513 GB, free: 15.03 MB / 1.123 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0009986/1.578, allocations: 219.3 kB / 1.513 GB, free: 14.82 MB / 1.123 GB Notification: Performance of SimCode: time 2.264e-06/1.578, allocations: 7.938 kB / 1.513 GB, free: 14.82 MB / 1.123 GB Notification: Performance of Templates: time 0.09658/1.675, allocations: 52.64 MB / 1.564 GB, free: 10.82 MB / 1.17 GB make -j1 -f Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.makefile (rm -f Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe >> ../files/Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.sim & ./Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe 2>&1) diffSimulationResults("Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_Sources_Examples_TraceSubstancesFlowSource.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) Reference file matches