Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_IDEAS.Fluid.Sensors.Examples.TraceSubstances.conf.json
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/IDEAS 3.0.0/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)
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 IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/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)
Running command: translateModel(IDEAS.Fluid.Sensors.Examples.TraceSubstances,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Sensors.Examples.TraceSubstances")
translateModel(IDEAS.Fluid.Sensors.Examples.TraceSubstances,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Sensors.Examples.TraceSubstances")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001436/0.001436, allocations: 182.9 kB / 15.98 MB, free: 5.77 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.7172/0.7172, allocations: 132.2 MB / 148.9 MB, free: 12.16 MB / 122.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.393/1.393, allocations: 222.9 MB / 403.3 MB, free: 7.07 MB / 314.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001073/0.001073, allocations: 105.9 kB / 484.3 MB, free: 8.684 MB / 394.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0009622/0.0009623, allocations: 55.92 kB / 0.5618 GB, free: 71.03 MB / 426.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1433/0.1442, allocations: 80.21 MB / 0.6402 GB, free: 6.75 MB / 442.7 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Sensors.Examples.TraceSubstances): time 0.5018/0.6461, allocations: 192.8 MB / 0.8285 GB, free: 2.234 MB / 0.5573 GB
Notification: Performance of NFInst.instExpressions: time 0.01616/0.6623, allocations: 14.4 MB / 0.8426 GB, free: 3.781 MB / 0.573 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001302/0.6637, allocations: 35.75 kB / 0.8426 GB, free: 3.746 MB / 0.573 GB
Notification: Performance of NFTyping.typeComponents: time 0.001348/0.665, allocations: 429.7 kB / 0.843 GB, free: 3.324 MB / 0.573 GB
Notification: Performance of NFTyping.typeBindings: time 0.004117/0.6692, allocations: 1.764 MB / 0.8447 GB, free: 1.555 MB / 0.573 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002049/0.6712, allocations: 0.767 MB / 0.8455 GB, free: 0.793 MB / 0.573 GB
Notification: Performance of NFFlatten.flatten: time 0.003593/0.6748, allocations: 3.634 MB / 0.849 GB, free: 13.15 MB / 0.5886 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001252/0.6761, allocations: 0.9441 MB / 0.85 GB, free: 12.18 MB / 0.5886 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004352/0.6805, allocations: 1.45 MB / 0.8514 GB, free: 10.74 MB / 0.5886 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001558/0.682, allocations: 0.9653 MB / 0.8523 GB, free: 9.777 MB / 0.5886 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001491/0.6822, allocations: 60 kB / 0.8524 GB, free: 9.719 MB / 0.5886 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002323/0.6845, allocations: 1.255 MB / 0.8536 GB, free: 8.461 MB / 0.5886 GB
Notification: Performance of NFScalarize.scalarize: time 0.0004928/0.685, allocations: 466.7 kB / 0.854 GB, free: 8.004 MB / 0.5886 GB
Notification: Performance of NFVerifyModel.verify: time 0.0007578/0.6858, allocations: 0.5792 MB / 0.8546 GB, free: 7.422 MB / 0.5886 GB
Notification: Performance of NFConvertDAE.convert: time 0.002265/0.6881, allocations: 1.928 MB / 0.8565 GB, free: 5.488 MB / 0.5886 GB
Notification: Performance of FrontEnd - DAE generated: time 4.338e-06/0.6881, allocations: 0 / 0.8565 GB, free: 5.488 MB / 0.5886 GB
Notification: Performance of FrontEnd: time 8.21e-07/0.6881, allocations: 4 kB / 0.8565 GB, free: 5.484 MB / 0.5886 GB
Notification: Performance of Transformations before backend: time 1.588e-05/0.6881, allocations: 0 / 0.8565 GB, free: 5.484 MB / 0.5886 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.002219/0.6904, allocations: 1.445 MB / 0.8579 GB, free: 3.984 MB / 0.5886 GB
Notification: Performance of prepare preOptimizeDAE: time 4.031e-05/0.6904, allocations: 12.03 kB / 0.8579 GB, free: 3.973 MB / 0.5886 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001322/0.6917, allocations: 258.3 kB / 0.8582 GB, free: 3.719 MB / 0.5886 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001589/0.6933, allocations: 0.7531 MB / 0.8589 GB, free: 2.922 MB / 0.5886 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.172e-05/0.6934, allocations: 74 kB / 0.859 GB, free: 2.848 MB / 0.5886 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000144/0.6936, allocations: 92 kB / 0.8591 GB, free: 2.758 MB / 0.5886 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001737/0.6953, allocations: 1.169 MB / 0.8602 GB, free: 1.52 MB / 0.5886 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.586e-05/0.6954, allocations: 11.81 kB / 0.8602 GB, free: 1.508 MB / 0.5886 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.565e-05/0.6954, allocations: 40 kB / 0.8602 GB, free: 1.469 MB / 0.5886 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.051e-05/0.6955, allocations: 33.98 kB / 0.8603 GB, free: 1.434 MB / 0.5886 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001381/0.6969, allocations: 0.9054 MB / 0.8612 GB, free: 0.5273 MB / 0.5886 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.005597/0.7025, allocations: 5.715 MB / 0.8667 GB, free: 10.36 MB / 0.6042 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0007679/0.7033, allocations: 0.5304 MB / 0.8673 GB, free: 9.816 MB / 0.6042 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004139/0.7037, allocations: 322.6 kB / 0.8676 GB, free: 9.5 MB / 0.6042 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005784/0.7043, allocations: 311.8 kB / 0.8679 GB, free: 9.141 MB / 0.6042 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.943e-05/0.7043, allocations: 35 kB / 0.8679 GB, free: 9.098 MB / 0.6042 GB
Notification: Performance of pre-optimization done (n=49): time 2.134e-06/0.7043, allocations: 0 / 0.8679 GB, free: 9.098 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=49): time 0.001402/0.7057, allocations: 0.8065 MB / 0.8687 GB, free: 8.289 MB / 0.6042 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.781e-05/0.7058, allocations: 55.84 kB / 0.8687 GB, free: 8.219 MB / 0.6042 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0008455/0.7066, allocations: 0.7509 MB / 0.8695 GB, free: 7.461 MB / 0.6042 GB
Notification: Performance of collectPreVariables (initialization): time 4.544e-05/0.7067, allocations: 41.64 kB / 0.8695 GB, free: 7.414 MB / 0.6042 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003482/0.707, allocations: 0.5104 MB / 0.87 GB, free: 6.895 MB / 0.6042 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001507/0.7072, allocations: 173.5 kB / 0.8702 GB, free: 6.723 MB / 0.6042 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002053/0.7074, allocations: 138.6 kB / 0.8703 GB, free: 6.582 MB / 0.6042 GB
Notification: Performance of setup shared object (initialization): time 0.0001129/0.7075, allocations: 338 kB / 0.8706 GB, free: 6.246 MB / 0.6042 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003612/0.7079, allocations: 249.8 kB / 0.8709 GB, free: 6.004 MB / 0.6042 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0006236/0.7086, allocations: 0.5644 MB / 0.8714 GB, free: 5.301 MB / 0.6042 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0009564/0.7095, allocations: 0.7956 MB / 0.8722 GB, free: 4.398 MB / 0.6042 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.878e-06/0.7095, allocations: 0 / 0.8722 GB, free: 4.398 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=86) (initialization): time 0.001179/0.7107, allocations: 0.8503 MB / 0.873 GB, free: 3.539 MB / 0.6042 GB
Notification: Performance of prepare postOptimizeDAE: time 1.698e-05/0.7107, allocations: 8 kB / 0.873 GB, free: 3.531 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.027e-05/0.7108, allocations: 8 kB / 0.873 GB, free: 3.523 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.995e-05/0.7108, allocations: 12 kB / 0.8731 GB, free: 3.512 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005348/0.7113, allocations: 151.8 kB / 0.8732 GB, free: 3.363 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.879e-05/0.7114, allocations: 17.81 kB / 0.8732 GB, free: 3.348 MB / 0.6042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008199/0.7122, allocations: 149.2 kB / 0.8734 GB, free: 3.203 MB / 0.6042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.39e-05/0.7123, allocations: 32 kB / 0.8734 GB, free: 3.172 MB / 0.6042 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.000399/0.7127, allocations: 330.8 kB / 0.8737 GB, free: 2.84 MB / 0.6042 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001219/0.7128, allocations: 82.97 kB / 0.8738 GB, free: 2.758 MB / 0.6042 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0009732/0.7138, allocations: 0.6218 MB / 0.8744 GB, free: 2.125 MB / 0.6042 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.962e-06/0.7138, allocations: 4 kB / 0.8744 GB, free: 2.121 MB / 0.6042 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.388e-06/0.7138, allocations: 4 kB / 0.8744 GB, free: 2.117 MB / 0.6042 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0006985/0.7145, allocations: 0.5133 MB / 0.8749 GB, free: 1.594 MB / 0.6042 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002376/0.7169, allocations: 1.667 MB / 0.8765 GB, free: 15.84 MB / 0.6198 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.211e-06/0.7169, allocations: 4 kB / 0.8765 GB, free: 15.84 MB / 0.6198 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000514/0.7174, allocations: 115.8 kB / 0.8766 GB, free: 15.72 MB / 0.6198 GB
Notification: Performance of postOpt tearingSystem (simulation): time 6.322e-06/0.7174, allocations: 4 kB / 0.8766 GB, free: 15.72 MB / 0.6198 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.582e-05/0.7175, allocations: 12 kB / 0.8767 GB, free: 15.71 MB / 0.6198 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 4.708e-06/0.7175, allocations: 4 kB / 0.8767 GB, free: 15.7 MB / 0.6198 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.11e-06/0.7175, allocations: 7.938 kB / 0.8767 GB, free: 15.7 MB / 0.6198 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00649/0.724, allocations: 4.716 MB / 0.8813 GB, free: 10.79 MB / 0.6198 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003409/0.7244, allocations: 235.8 kB / 0.8815 GB, free: 10.54 MB / 0.6198 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 8.093e-05/0.7244, allocations: 8 kB / 0.8815 GB, free: 10.53 MB / 0.6198 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005444/0.725, allocations: 63.88 kB / 0.8816 GB, free: 10.47 MB / 0.6198 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 6.429e-05/0.7251, allocations: 35.91 kB / 0.8816 GB, free: 10.43 MB / 0.6198 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.035e-05/0.7251, allocations: 28.12 kB / 0.8816 GB, free: 10.41 MB / 0.6198 GB
Notification: Performance of sorting global known variables: time 0.0006017/0.7257, allocations: 0.5068 MB / 0.8821 GB, free: 9.902 MB / 0.6198 GB
Notification: Performance of sort global known variables: time 1.41e-07/0.7257, allocations: 4 kB / 0.8821 GB, free: 9.898 MB / 0.6198 GB
Notification: Performance of remove unused functions: time 0.00168/0.7274, allocations: 435.3 kB / 0.8825 GB, free: 9.473 MB / 0.6198 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.0004642/0.7279, allocations: 216 kB / 0.8827 GB, free: 9.266 MB / 0.6198 GB
Notification: Performance of simCode: created initialization part: time 0.0008902/0.7288, allocations: 0.6044 MB / 0.8833 GB, free: 8.66 MB / 0.6198 GB
Notification: Performance of simCode: created event and clocks part: time 3.015e-06/0.7288, allocations: 0 / 0.8833 GB, free: 8.66 MB / 0.6198 GB
Notification: Performance of simCode: created simulation system equations: time 0.0003481/0.7292, allocations: 275.6 kB / 0.8836 GB, free: 8.391 MB / 0.6198 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002003/0.7312, allocations: 450 kB / 0.884 GB, free: 7.961 MB / 0.6198 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003099/0.7343, allocations: 2.639 MB / 0.8866 GB, free: 5.258 MB / 0.6198 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006816/0.735, allocations: 1.134 MB / 0.8877 GB, free: 4.098 MB / 0.6198 GB
Notification: Performance of simCode: alias equations: time 0.0008123/0.7358, allocations: 275.1 kB / 0.888 GB, free: 3.824 MB / 0.6198 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002019/0.736, allocations: 71.42 kB / 0.888 GB, free: 3.754 MB / 0.6198 GB
Notification: Performance of SimCode: time 2.81e-07/0.736, allocations: 0 / 0.888 GB, free: 3.754 MB / 0.6198 GB
Notification: Performance of Templates: time 0.02502/0.761, allocations: 16.22 MB / 0.9039 GB, free: 3.75 MB / 0.6355 GB
make -j1 -f IDEAS_IDEAS.Fluid.Sensors.Examples.TraceSubstances.makefile
(rm -f IDEAS_IDEAS.Fluid.Sensors.Examples.TraceSubstances.pipe ; mkfifo IDEAS_IDEAS.Fluid.Sensors.Examples.TraceSubstances.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.Sensors.Examples.TraceSubstances.pipe >> ../files/IDEAS_IDEAS.Fluid.Sensors.Examples.TraceSubstances.sim & ./IDEAS_IDEAS.Fluid.Sensors.Examples.TraceSubstances  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Fluid.Sensors.Examples.TraceSubstances.pipe 2>&1)