Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo", uses=false) Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/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) 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 BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo) Running command: "" <> buildModelFMU(BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance,fileNamePrefix="BuildingSystems_BuildingSystems_Fluid_MixingVolumes_Validation_MixingVolumeTraceSubstance",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance,fileNamePrefix="BuildingSystems_BuildingSystems_Fluid_MixingVolumes_Validation_MixingVolumeTraceSubstance",fmuType="me",version="2.0",platforms={"static"}) Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo): time 0.6843/0.6843, allocations: 141.7 MB / 154.3 MB, free: 15.49 MB / 138.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.0009204/0.0009205, allocations: 183.7 kB / 187.3 MB, free: 11.88 MB / 154.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.226/1.226, allocations: 221.3 MB / 441.4 MB, free: 4.664 MB / 330.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0008078/0.0008079, allocations: 95.12 kB / 0.5124 GB, free: 24.31 MB / 394.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo): time 0.001635/0.001635, allocations: 279.2 kB / 0.5939 GB, free: 7.977 MB / 442.7 MB Notification: Performance of FrontEnd - loaded program: time 3.611e-05/3.613e-05, allocations: 12 kB / 0.6835 GB, free: 12.16 MB / 0.5261 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3716/0.3716, allocations: 82.76 MB / 0.7644 GB, free: 108.7 MB / 0.5261 GB Notification: Performance of FrontEnd - scodeFlatten: time 3.704/4.076, allocations: 1.88 GB / 2.644 GB, free: 127.2 MB / 0.698 GB Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003114/4.076, allocations: 86.25 kB / 2.645 GB, free: 127.1 MB / 0.698 GB Notification: Performance of FrontEnd - DAE generated: time 1.726/5.802, allocations: 0.5716 GB / 3.216 GB, free: 89.89 MB / 0.698 GB Notification: Performance of FrontEnd: time 1.032e-06/5.802, allocations: 0 / 3.216 GB, free: 89.89 MB / 0.698 GB Notification: Performance of Transformations before backend: time 6.293e-05/5.802, allocations: 35.98 kB / 3.216 GB, free: 89.86 MB / 0.698 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 212 * Number of variables: 212 Notification: Performance of Generate backend data structure: time 0.001899/5.804, allocations: 1.229 MB / 3.217 GB, free: 88.58 MB / 0.698 GB Notification: Performance of prepare preOptimizeDAE: time 4.135e-05/5.804, allocations: 8.031 kB / 3.217 GB, free: 88.57 MB / 0.698 GB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001374/5.804, allocations: 135.2 kB / 3.217 GB, free: 88.43 MB / 0.698 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001596/5.805, allocations: 326.3 kB / 3.218 GB, free: 88.11 MB / 0.698 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.001232/5.807, allocations: 0.7886 MB / 3.219 GB, free: 87.28 MB / 0.698 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003182/5.807, allocations: 129.9 kB / 3.219 GB, free: 87.15 MB / 0.698 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001092/5.807, allocations: 91.98 kB / 3.219 GB, free: 87.06 MB / 0.698 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.00129/5.808, allocations: 0.9918 MB / 3.22 GB, free: 86.03 MB / 0.698 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.237e-05/5.809, allocations: 7.938 kB / 3.22 GB, free: 86.02 MB / 0.698 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.654e-05/5.809, allocations: 36 kB / 3.22 GB, free: 85.99 MB / 0.698 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.277e-05/5.809, allocations: 34 kB / 3.22 GB, free: 85.96 MB / 0.698 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0009441/5.81, allocations: 0.7262 MB / 3.221 GB, free: 85.23 MB / 0.698 GB Warning: The model contains alias variables with conflicting start and/or 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.004136/5.814, allocations: 4.045 MB / 3.224 GB, free: 80.93 MB / 0.698 GB Notification: Performance of preOpt comSubExp (simulation): time 0.0004504/5.814, allocations: 374 kB / 3.225 GB, free: 80.55 MB / 0.698 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.000228/5.814, allocations: 204 kB / 3.225 GB, free: 80.35 MB / 0.698 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0001653/5.815, allocations: 101.1 kB / 3.225 GB, free: 80.23 MB / 0.698 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 1.937e-05/5.815, allocations: 42.5 kB / 3.225 GB, free: 80.18 MB / 0.698 GB Notification: Performance of pre-optimization done (n=36): time 3.116e-06/5.815, allocations: 0 / 3.225 GB, free: 80.18 MB / 0.698 GB Notification: Performance of matching and sorting (n=38): time 0.001839/5.816, allocations: 1.179 MB / 3.226 GB, free: 78.95 MB / 0.698 GB Notification: Performance of inlineWhenForInitialization (initialization): time 2.267e-05/5.817, allocations: 55.41 kB / 3.226 GB, free: 78.88 MB / 0.698 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.000804/5.817, allocations: 0.8349 MB / 3.227 GB, free: 78.02 MB / 0.698 GB Notification: Performance of collectPreVariables (initialization): time 3.646e-05/5.817, allocations: 37.7 kB / 3.227 GB, free: 77.98 MB / 0.698 GB Notification: Performance of collectInitialEqns (initialization): time 0.0002156/5.818, allocations: 491.3 kB / 3.228 GB, free: 77.5 MB / 0.698 GB Notification: Performance of collectInitialBindings (initialization): time 7.654e-05/5.818, allocations: 138.1 kB / 3.228 GB, free: 77.36 MB / 0.698 GB Notification: Performance of simplifyInitialFunctions (initialization): time 2.528e-05/5.818, allocations: 12 kB / 3.228 GB, free: 77.35 MB / 0.698 GB Notification: Performance of setup shared object (initialization): time 5.482e-05/5.818, allocations: 330 kB / 3.228 GB, free: 77.02 MB / 0.698 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002495/5.818, allocations: 197.5 kB / 3.228 GB, free: 76.83 MB / 0.698 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0003155/5.818, allocations: 389.6 kB / 3.229 GB, free: 76.37 MB / 0.698 GB Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: volDyn.dynBal.medium.p = volDyn.dynBal.p_start (bou.p = volDyn.dynBal.p_start) Notification: Performance of analyzeInitialSystem (initialization): time 0.001487/5.82, allocations: 0.6951 MB / 3.229 GB, free: 75.66 MB / 0.698 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.564e-06/5.82, allocations: 0 / 3.229 GB, free: 75.66 MB / 0.698 GB Notification: Performance of matching and sorting (n=71) (initialization): time 0.0007996/5.821, allocations: 0.6796 MB / 3.23 GB, free: 74.97 MB / 0.698 GB Notification: Performance of prepare postOptimizeDAE: time 1.681e-05/5.821, allocations: 8 kB / 3.23 GB, free: 74.96 MB / 0.698 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.426e-06/5.821, allocations: 4 kB / 3.23 GB, free: 74.96 MB / 0.698 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.977e-05/5.821, allocations: 11.95 kB / 3.23 GB, free: 74.95 MB / 0.698 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005013/5.821, allocations: 143.7 kB / 3.23 GB, free: 74.81 MB / 0.698 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.367e-05/5.821, allocations: 12.22 kB / 3.23 GB, free: 74.8 MB / 0.698 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008827/5.822, allocations: 95.77 kB / 3.23 GB, free: 74.7 MB / 0.698 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.123e-05/5.822, allocations: 28 kB / 3.23 GB, free: 74.68 MB / 0.698 GB Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization sytem: volDyn.dynBal.medium.p = volDyn.dynBal.p_start. Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 22 * Number of states: 0 () * Number of discrete variables: 0 () * Number of discrete states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (71): * Single equations (assignments): 71 * 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: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of prepare postOptimizeDAE: time 0.0001124/5.822, allocations: 153.1 kB / 3.23 GB, free: 74.52 MB / 0.698 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001102/5.822, allocations: 98.88 kB / 3.231 GB, free: 74.42 MB / 0.698 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.000168/5.823, allocations: 101 kB / 3.231 GB, free: 74.32 MB / 0.698 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.889e-06/5.823, allocations: 7.953 kB / 3.231 GB, free: 74.31 MB / 0.698 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 5.891e-06/5.823, allocations: 0 / 3.231 GB, free: 74.31 MB / 0.698 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0004706/5.823, allocations: 0.6596 MB / 3.231 GB, free: 73.57 MB / 0.698 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001844/5.825, allocations: 1.572 MB / 3.233 GB, free: 71.89 MB / 0.698 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.228e-06/5.825, allocations: 4 kB / 3.233 GB, free: 71.89 MB / 0.698 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00035/5.825, allocations: 87.89 kB / 3.233 GB, free: 71.8 MB / 0.698 GB Notification: Performance of postOpt tearingSystem (simulation): time 8.095e-06/5.825, allocations: 8 kB / 3.233 GB, free: 71.79 MB / 0.698 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 2.731e-05/5.825, allocations: 12.5 kB / 3.233 GB, free: 71.78 MB / 0.698 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 5.089e-06/5.825, allocations: 4 kB / 3.233 GB, free: 71.78 MB / 0.698 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.406e-06/5.825, allocations: 11.94 kB / 3.233 GB, free: 71.77 MB / 0.698 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0007957/5.826, allocations: 1.052 MB / 3.234 GB, free: 70.56 MB / 0.698 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0003081/5.827, allocations: 231.9 kB / 3.234 GB, free: 70.31 MB / 0.698 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001059/5.827, allocations: 19.98 kB / 3.234 GB, free: 70.29 MB / 0.698 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006488/5.827, allocations: 51.88 kB / 3.234 GB, free: 70.24 MB / 0.698 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 5.279e-05/5.827, allocations: 47.88 kB / 3.234 GB, free: 70.2 MB / 0.698 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.104e-05/5.827, allocations: 32.05 kB / 3.234 GB, free: 70.16 MB / 0.698 GB Notification: Performance of sorting global known variables: time 0.0006625/5.828, allocations: 0.6529 MB / 3.235 GB, free: 69.5 MB / 0.698 GB Notification: Performance of sort global known variables: time 1.7e-07/5.828, allocations: 0 / 3.235 GB, free: 69.5 MB / 0.698 GB Notification: Performance of remove unused functions: time 0.001115/5.829, allocations: 383.9 kB / 3.235 GB, free: 69.12 MB / 0.698 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 17 * Number of states: 3 (volDyn.dynBal.U,volDyn.dynBal.mXi[1],volDyn.dynBal.mC[1]) * Number of discrete variables: 0 () * Number of discrete states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (38): * Single equations (assignments): 38 * 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: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of Backend phase and start with SimCode phase: time 0.00258/5.832, allocations: 3.89 MB / 3.239 GB, free: 65.05 MB / 0.698 GB Notification: Performance of simCode: created initialization part: time 0.0006371/5.832, allocations: 452.5 kB / 3.24 GB, free: 64.61 MB / 0.698 GB Notification: Performance of simCode: created event and clocks part: time 3.857e-06/5.832, allocations: 4 kB / 3.24 GB, free: 64.61 MB / 0.698 GB Notification: Performance of simCode: created simulation system equations: time 0.0001933/5.833, allocations: 188.8 kB / 3.24 GB, free: 64.42 MB / 0.698 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002317/5.835, allocations: 0.5811 MB / 3.24 GB, free: 63.85 MB / 0.698 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002406/5.837, allocations: 1.678 MB / 3.242 GB, free: 62.07 MB / 0.698 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004169/5.838, allocations: 1.114 MB / 3.243 GB, free: 60.93 MB / 0.698 GB Notification: Performance of simCode: alias equations: time 0.000775/5.839, allocations: 240.2 kB / 3.243 GB, free: 60.69 MB / 0.698 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000364/5.839, allocations: 335.3 kB / 3.244 GB, free: 60.36 MB / 0.698 GB Notification: Performance of SimCode: time 1.112e-06/5.839, allocations: 0 / 3.244 GB, free: 60.36 MB / 0.698 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.06334/5.902, allocations: 50.67 MB / 3.293 GB, free: 9.938 MB / 0.698 GB Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0001292/5.903, allocations: 223.1 kB / 3.293 GB, free: 9.711 MB / 0.698 GB Notification: Performance of buildModelFMU: Generate platform static: time 3.365/9.268, allocations: 0 / 3.293 GB, free: 9.711 MB / 0.698 GB (rm -f BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance.pipe ; mkfifo BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance.pipe >> ../files/BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator --tempDir=temp_BuildingSystems_BuildingSystems_Fluid_MixingVolumes_Validation_MixingVolumeTraceSubstance_fmu --startTime=0 --stopTime=10 --timeout=50 --tolerance=1e-06 BuildingSystems_BuildingSystems_Fluid_MixingVolumes_Validation_MixingVolumeTraceSubstance.fmu > BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeTraceSubstance.pipe 2>&1)