Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Sensors.Examples.TraceSubstances.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/IDEAS 3.0.0-master/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-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: "" <> buildModelFMU(IDEAS.Fluid.Sensors.Examples.TraceSubstances,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_Sensors_Examples_TraceSubstances",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IDEAS.Fluid.Sensors.Examples.TraceSubstances,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_Sensors_Examples_TraceSubstances",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0007444/0.0007445, allocations: 91.45 kB / 15.36 MB, free: 0.7383 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.004137/0.004137, allocations: 169.8 kB / 16.26 MB, free: 6.676 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.221/1.221, allocations: 223.3 MB / 240.3 MB, free: 5.34 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.8612/0.8612, allocations: 135.3 MB / 426.7 MB, free: 14.26 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003407/0.0003407, allocations: 12 kB / 0.5077 GB, free: 4.66 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.152/0.1524, allocations: 82.3 MB / 0.5881 GB, free: 2.527 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Sensors.Examples.TraceSubstances): time 0.4227/0.5751, allocations: 190.3 MB / 0.7739 GB, free: 14.02 MB / 0.5919 GB
Notification: Performance of NFInst.instExpressions: time 0.0154/0.5906, allocations: 14.22 MB / 0.7878 GB, free: 15.75 MB / 0.6075 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0007558/0.5913, allocations: 27.81 kB / 0.7878 GB, free: 15.73 MB / 0.6075 GB
Notification: Performance of NFTyping.typeComponents: time 0.001116/0.5925, allocations: 409.8 kB / 0.7882 GB, free: 15.32 MB / 0.6075 GB
Notification: Performance of NFTyping.typeBindings: time 0.003653/0.5961, allocations: 1.775 MB / 0.7899 GB, free: 13.54 MB / 0.6075 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001751/0.5979, allocations: 0.7781 MB / 0.7907 GB, free: 12.77 MB / 0.6075 GB
Notification: Performance of NFFlatten.flatten: time 0.003055/0.601, allocations: 3.616 MB / 0.7942 GB, free: 9.152 MB / 0.6075 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001025/0.602, allocations: 0.9156 MB / 0.7951 GB, free: 8.211 MB / 0.6075 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003409/0.6054, allocations: 1.398 MB / 0.7965 GB, free: 6.82 MB / 0.6075 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001204/0.6066, allocations: 0.9196 MB / 0.7974 GB, free: 5.898 MB / 0.6075 GB
Notification: Performance of NFPackage.collectConstants: time 9.713e-05/0.6067, allocations: 48 kB / 0.7974 GB, free: 5.852 MB / 0.6075 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001772/0.6085, allocations: 1.243 MB / 0.7986 GB, free: 4.605 MB / 0.6075 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003717/0.6089, allocations: 430.8 kB / 0.7991 GB, free: 4.184 MB / 0.6075 GB
Notification: Performance of NFVerifyModel.verify: time 0.0005016/0.6094, allocations: 0.5963 MB / 0.7996 GB, free: 3.578 MB / 0.6075 GB
Notification: Performance of NFConvertDAE.convert: time 0.001758/0.6112, allocations: 1.888 MB / 0.8015 GB, free: 1.684 MB / 0.6075 GB
Notification: Performance of FrontEnd - DAE generated: time 3.627e-06/0.6112, allocations: 4 kB / 0.8015 GB, free: 1.68 MB / 0.6075 GB
Notification: Performance of FrontEnd: time 1.442e-06/0.6112, allocations: 0 / 0.8015 GB, free: 1.68 MB / 0.6075 GB
Notification: Performance of Transformations before backend: time 1.205e-05/0.6112, allocations: 0 / 0.8015 GB, free: 1.68 MB / 0.6075 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 226
 * Number of variables: 226
Notification: Performance of Generate backend data structure: time 0.001726/0.6129, allocations: 1.231 MB / 0.8027 GB, free: 408 kB / 0.6075 GB
Notification: Performance of prepare preOptimizeDAE: time 3.637e-05/0.613, allocations: 12.03 kB / 0.8027 GB, free: 396 kB / 0.6075 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001547/0.6132, allocations: 139.6 kB / 0.8028 GB, free: 248 kB / 0.6075 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001288/0.6144, allocations: 254.6 kB / 0.8031 GB, free: 15.99 MB / 0.6231 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001032/0.6155, allocations: 0.7608 MB / 0.8038 GB, free: 15.19 MB / 0.6231 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.452e-05/0.6156, allocations: 70 kB / 0.8039 GB, free: 15.12 MB / 0.6231 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000129/0.6157, allocations: 88 kB / 0.804 GB, free: 15.04 MB / 0.6231 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001553/0.6173, allocations: 1.165 MB / 0.8051 GB, free: 13.8 MB / 0.6231 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.538e-05/0.6173, allocations: 15.88 kB / 0.8051 GB, free: 13.79 MB / 0.6231 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.725e-05/0.6174, allocations: 36 kB / 0.8052 GB, free: 13.75 MB / 0.6231 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.219e-05/0.6174, allocations: 45.92 kB / 0.8052 GB, free: 13.7 MB / 0.6231 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001308/0.6187, allocations: 0.8937 MB / 0.8061 GB, free: 12.81 MB / 0.6231 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.004657/0.6234, allocations: 5.723 MB / 0.8117 GB, free: 6.629 MB / 0.6231 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0007084/0.6241, allocations: 0.5378 MB / 0.8122 GB, free: 6.086 MB / 0.6231 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003804/0.6245, allocations: 322.5 kB / 0.8125 GB, free: 5.773 MB / 0.6231 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005283/0.6251, allocations: 327.7 kB / 0.8128 GB, free: 5.398 MB / 0.6231 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.582e-05/0.6251, allocations: 39 kB / 0.8128 GB, free: 5.348 MB / 0.6231 GB
Notification: Performance of pre-optimization done (n=49): time 1.624e-06/0.6251, allocations: 0 / 0.8128 GB, free: 5.348 MB / 0.6231 GB
Notification: Performance of matching and sorting (n=49): time 0.001293/0.6264, allocations: 0.8026 MB / 0.8136 GB, free: 4.539 MB / 0.6231 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.391e-05/0.6264, allocations: 55.84 kB / 0.8137 GB, free: 4.473 MB / 0.6231 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0007609/0.6272, allocations: 0.7548 MB / 0.8144 GB, free: 3.711 MB / 0.6231 GB
Notification: Performance of collectPreVariables (initialization): time 4.386e-05/0.6273, allocations: 37.7 kB / 0.8145 GB, free: 3.668 MB / 0.6231 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003057/0.6276, allocations: 0.5065 MB / 0.8149 GB, free: 3.152 MB / 0.6231 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001261/0.6277, allocations: 177.5 kB / 0.8151 GB, free: 2.977 MB / 0.6231 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 7.541e-05/0.6278, allocations: 61.69 kB / 0.8152 GB, free: 2.91 MB / 0.6231 GB
Notification: Performance of setup shared object (initialization): time 9.728e-05/0.6279, allocations: 338 kB / 0.8155 GB, free: 2.574 MB / 0.6231 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003394/0.6282, allocations: 249.8 kB / 0.8157 GB, free: 2.332 MB / 0.6231 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000537/0.6288, allocations: 0.5566 MB / 0.8163 GB, free: 1.645 MB / 0.6231 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.000887/0.6297, allocations: 0.7956 MB / 0.8171 GB, free: 0.7383 MB / 0.6231 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.608e-06/0.6297, allocations: 0 / 0.8171 GB, free: 0.7383 MB / 0.6231 GB
Notification: Performance of matching and sorting (n=86) (initialization): time 0.001113/0.6308, allocations: 0.8465 MB / 0.8179 GB, free: 15.88 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 1.657e-05/0.6308, allocations: 8 kB / 0.8179 GB, free: 15.88 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.19e-05/0.6308, allocations: 12 kB / 0.8179 GB, free: 15.86 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.63e-05/0.6309, allocations: 12 kB / 0.8179 GB, free: 15.85 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005146/0.6314, allocations: 155.7 kB / 0.8181 GB, free: 15.7 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.969e-05/0.6314, allocations: 18.52 kB / 0.8181 GB, free: 15.68 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007599/0.6322, allocations: 143.3 kB / 0.8182 GB, free: 15.54 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.406e-05/0.6322, allocations: 39.98 kB / 0.8183 GB, free: 15.5 MB / 0.6387 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 36
 * 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 (86):
 * Single equations (assignments): 86
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.000351/0.6326, allocations: 321.5 kB / 0.8186 GB, free: 15.18 MB / 0.6387 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001086/0.6327, allocations: 90.95 kB / 0.8186 GB, free: 15.09 MB / 0.6387 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0009022/0.6336, allocations: 0.6179 MB / 0.8193 GB, free: 14.46 MB / 0.6387 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.561e-06/0.6336, allocations: 11.94 kB / 0.8193 GB, free: 14.45 MB / 0.6387 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.027e-06/0.6336, allocations: 0 / 0.8193 GB, free: 14.45 MB / 0.6387 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0006578/0.6343, allocations: 0.5172 MB / 0.8198 GB, free: 13.92 MB / 0.6387 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002091/0.6364, allocations: 1.658 MB / 0.8214 GB, free: 12.19 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.167e-06/0.6364, allocations: 4 kB / 0.8214 GB, free: 12.18 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004884/0.6369, allocations: 111.8 kB / 0.8215 GB, free: 12.07 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (simulation): time 6.211e-06/0.6369, allocations: 7.984 kB / 0.8215 GB, free: 12.07 MB / 0.6387 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.222e-05/0.637, allocations: 12 kB / 0.8215 GB, free: 12.05 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 4.248e-06/0.637, allocations: 4 kB / 0.8215 GB, free: 12.05 MB / 0.6387 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.176e-06/0.637, allocations: 4 kB / 0.8215 GB, free: 12.05 MB / 0.6387 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001198/0.6382, allocations: 1.058 MB / 0.8226 GB, free: 10.95 MB / 0.6387 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002546/0.6385, allocations: 228 kB / 0.8228 GB, free: 10.71 MB / 0.6387 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 8.733e-05/0.6386, allocations: 12 kB / 0.8228 GB, free: 10.7 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000525/0.6391, allocations: 67.78 kB / 0.8229 GB, free: 10.63 MB / 0.6387 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 6.026e-05/0.6392, allocations: 35.89 kB / 0.8229 GB, free: 10.6 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.071e-05/0.6392, allocations: 16 kB / 0.8229 GB, free: 10.58 MB / 0.6387 GB
Notification: Performance of sorting global known variables: time 0.0005437/0.6397, allocations: 0.5146 MB / 0.8234 GB, free: 10.07 MB / 0.6387 GB
Notification: Performance of sort global known variables: time 1.4e-07/0.6398, allocations: 4 kB / 0.8234 GB, free: 10.07 MB / 0.6387 GB
Notification: Performance of remove unused functions: time 0.0007025/0.6405, allocations: 295.4 kB / 0.8237 GB, free: 9.777 MB / 0.6387 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 8
 * Number of states: 4 (vol.dynBal.U,vol.dynBal.m,vol.dynBal.mXi[1],vol.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 (49):
 * Single equations (assignments): 49
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.001697/0.6422, allocations: 1.702 MB / 0.8254 GB, free: 8.039 MB / 0.6387 GB
Notification: Performance of simCode: created initialization part: time 0.000812/0.643, allocations: 0.6074 MB / 0.8259 GB, free: 7.43 MB / 0.6387 GB
Notification: Performance of simCode: created event and clocks part: time 2.585e-06/0.643, allocations: 0 / 0.8259 GB, free: 7.43 MB / 0.6387 GB
Notification: Performance of simCode: created simulation system equations: time 0.0003356/0.6433, allocations: 271.7 kB / 0.8262 GB, free: 7.164 MB / 0.6387 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002111/0.6455, allocations: 441.3 kB / 0.8266 GB, free: 6.75 MB / 0.6387 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008566/0.654, allocations: 7.924 MB / 0.8344 GB, free: 14.42 MB / 0.6544 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005773/0.6546, allocations: 1.122 MB / 0.8355 GB, free: 13.27 MB / 0.6544 GB
Notification: Performance of simCode: alias equations: time 0.0007125/0.6553, allocations: 275.1 kB / 0.8357 GB, free: 13 MB / 0.6544 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004038/0.6558, allocations: 355.3 kB / 0.8361 GB, free: 12.65 MB / 0.6544 GB
Notification: Performance of SimCode: time 2.71e-07/0.6558, allocations: 0 / 0.8361 GB, free: 12.65 MB / 0.6544 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 4.406/5.062, allocations: 22.11 MB / 0.8577 GB, free: 6.895 MB / 0.67 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0002537/5.062, allocations: 234.1 kB / 0.8579 GB, free: 6.637 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate platform static: time 2.687/7.749, allocations: 64 / 0.8579 GB, free: 6.637 MB / 0.67 GB
(rm -f IDEAS_dev_IDEAS.Fluid.Sensors.Examples.TraceSubstances.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Sensors.Examples.TraceSubstances.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Sensors.Examples.TraceSubstances.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Sensors.Examples.TraceSubstances.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_IDEAS_dev_IDEAS_Fluid_Sensors_Examples_TraceSubstances_fmu --startTime=0 --stopTime=7200 --timeout=50 --tolerance=1e-06 IDEAS_dev_IDEAS_Fluid_Sensors_Examples_TraceSubstances.fmu > IDEAS_dev_IDEAS.Fluid.Sensors.Examples.TraceSubstances.pipe 2>&1)