Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler.conf.json
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)
Running command: translateModel(Modelica.Fluid.Examples.DrumBoiler.DrumBoiler,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|controller.x|evaporator.V_l|evaporator.p",fileNamePrefix="Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler")
translateModel(Modelica.Fluid.Examples.DrumBoiler.DrumBoiler,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|controller.x|evaporator.V_l|evaporator.p",fileNamePrefix="Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001147/0.001147, allocations: 184.1 kB / 18.04 MB, free: 3.777 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.345/1.345, allocations: 205.4 MB / 224.2 MB, free: 9.012 MB / 186.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0008452/0.0008452, allocations: 88.41 kB / 272.5 MB, free: 8.25 MB / 218.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003221/0.0003223, allocations: 12 kB / 329.4 MB, free: 15.27 MB / 282.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2461/0.2465, allocations: 47.58 MB / 377 MB, free: 45.64 MB / 298.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 5.41/5.657, allocations: 2.833 GB / 3.201 GB, free: 48.36 MB / 426.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002383/5.657, allocations: 87.95 kB / 3.201 GB, free: 48.27 MB / 426.7 MB
Notification: Performance of FrontEnd - DAE generated: time 1.509/7.166, allocations: 475.1 MB / 3.665 GB, free: 46.92 MB / 442.7 MB
Notification: Performance of FrontEnd: time 2.174e-06/7.166, allocations: 0 / 3.665 GB, free: 46.92 MB / 442.7 MB
Notification: Performance of Transformations before backend: time 5.188e-05/7.166, allocations: 16.94 kB / 3.665 GB, free: 46.92 MB / 442.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 152
 * Number of variables: 152
Notification: Performance of Generate backend data structure: time 0.006187/7.173, allocations: 1.92 MB / 3.667 GB, free: 45.77 MB / 442.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.759e-05/7.173, allocations: 10.78 kB / 3.667 GB, free: 45.77 MB / 442.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002031/7.175, allocations: 249 kB / 3.667 GB, free: 45.73 MB / 442.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001058/7.176, allocations: 0.5273 MB / 3.668 GB, free: 45.45 MB / 442.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.613e-05/7.176, allocations: 45.34 kB / 3.668 GB, free: 45.45 MB / 442.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001113/7.176, allocations: 60.03 kB / 3.668 GB, free: 45.45 MB / 442.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001872/7.178, allocations: 0.9396 MB / 3.669 GB, free: 45.23 MB / 442.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.215e-05/7.178, allocations: 3.938 kB / 3.669 GB, free: 45.23 MB / 442.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.157e-05/7.178, allocations: 29.66 kB / 3.669 GB, free: 45.23 MB / 442.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.247e-05/7.178, allocations: 18.19 kB / 3.669 GB, free: 45.23 MB / 442.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001628/7.18, allocations: 0.7435 MB / 3.669 GB, free: 45.22 MB / 442.7 MB
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.004179/7.184, allocations: 4.184 MB / 3.674 GB, free: 41.95 MB / 442.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001574/7.185, allocations: 0.6669 MB / 3.674 GB, free: 41.71 MB / 442.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004431/7.186, allocations: 299.1 kB / 3.675 GB, free: 41.6 MB / 442.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.067/7.253, allocations: 38.87 MB / 3.712 GB, free: 18.48 MB / 442.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00159/7.254, allocations: 0.5922 MB / 3.713 GB, free: 18.21 MB / 442.7 MB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0004892/7.255, allocations: 97.03 kB / 3.713 GB, free: 18.17 MB / 442.7 MB
Notification: Performance of pre-optimization done (n=57): time 3.166e-06/7.255, allocations: 0 / 3.713 GB, free: 18.17 MB / 442.7 MB
Notification: Performance of matching and sorting (n=65): time 0.01003/7.265, allocations: 3.3 MB / 3.716 GB, free: 16.73 MB / 442.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.155e-05/7.265, allocations: 279.2 kB / 3.717 GB, free: 16.41 MB / 442.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0005089/7.266, allocations: 479.6 kB / 3.717 GB, free: 16.19 MB / 442.7 MB
Notification: Performance of collectPreVariables (initialization): time 6.503e-05/7.266, allocations: 41.36 kB / 3.717 GB, free: 16.15 MB / 442.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002329/7.266, allocations: 323.4 kB / 3.717 GB, free: 15.89 MB / 442.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.000142/7.266, allocations: 222 kB / 3.718 GB, free: 15.73 MB / 442.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 4.106e-05/7.266, allocations: 11.88 kB / 3.718 GB, free: 15.72 MB / 442.7 MB
Notification: Performance of setup shared object (initialization): time 8.634e-05/7.266, allocations: 369.2 kB / 3.718 GB, free: 15.38 MB / 442.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005015/7.267, allocations: 296.1 kB / 3.718 GB, free: 15.29 MB / 442.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0006161/7.267, allocations: 471.8 kB / 3.719 GB, free: 14.97 MB / 442.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001139/7.269, allocations: 0.8588 MB / 3.72 GB, free: 14.39 MB / 442.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.486e-06/7.269, allocations: 3.281 kB / 3.72 GB, free: 14.39 MB / 442.7 MB
Notification: Performance of matching and sorting (n=87) (initialization): time 0.001747/7.27, allocations: 1.068 MB / 3.721 GB, free: 13.93 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001293/7.27, allocations: 282.6 kB / 3.721 GB, free: 13.6 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.009e-05/7.271, allocations: 3.75 kB / 3.721 GB, free: 13.6 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003468/7.274, allocations: 358 kB / 3.721 GB, free: 13.51 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004811/7.274, allocations: 137.5 kB / 3.721 GB, free: 13.5 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.000922/7.275, allocations: 0.7995 MB / 3.722 GB, free: 12.86 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007583/7.276, allocations: 73.22 kB / 3.722 GB, free: 12.84 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.729e-05/7.276, allocations: 46.83 kB / 3.722 GB, free: 12.83 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 8.647e-06/7.276, allocations: 2.844 kB / 3.722 GB, free: 12.83 MB / 442.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.001659/7.278, allocations: 1.011 MB / 3.723 GB, free: 12.24 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.887e-06/7.278, allocations: 4 kB / 3.723 GB, free: 12.23 MB / 442.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003305/7.281, allocations: 359.8 kB / 3.724 GB, free: 12.01 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000439/7.282, allocations: 138.2 kB / 3.724 GB, free: 11.89 MB / 442.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0008755/7.283, allocations: 0.8041 MB / 3.725 GB, free: 11.12 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006999/7.283, allocations: 67.3 kB / 3.725 GB, free: 11.06 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.17e-05/7.283, allocations: 51.55 kB / 3.725 GB, free: 11.02 MB / 442.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 20
 * Number of states: 0 ()
 * Number of discrete variables: 19 ($whenCondition1,$whenCondition2,pump.medium.phase,q_F_Tab.a,q_F_Tab.b,q_F_Tab.last,$PRE.q_F_Tab.nextEvent,q_F_Tab.nextEvent,q_F_Tab.nextEventScaled,Y_Valve_Tab.a,Y_Valve_Tab.b,Y_Valve_Tab.last,$PRE.Y_Valve_Tab.nextEvent,Y_Valve_Tab.nextEvent,Y_Valve_Tab.nextEventScaled,SteamValve.state_b.phase,SteamValve.state_a.phase,sink.state.phase,sink.medium.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (70):
 * Single equations (assignments): 67
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {2 6}
Notification: Performance of prepare postOptimizeDAE: time 0.000498/7.284, allocations: 364.5 kB / 3.725 GB, free: 10.65 MB / 442.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001516/7.284, allocations: 67.25 kB / 3.725 GB, free: 10.59 MB / 442.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005023/7.289, allocations: 4.798 MB / 3.73 GB, free: 6.348 MB / 442.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.372e-05/7.289, allocations: 35 kB / 3.73 GB, free: 6.324 MB / 442.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 9.869e-06/7.289, allocations: 0 / 3.73 GB, free: 6.324 MB / 442.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.131e-05/7.289, allocations: 3.656 kB / 3.73 GB, free: 6.324 MB / 442.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006609/7.296, allocations: 6.573 MB / 3.736 GB, free: 0.5078 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.754e-06/7.296, allocations: 0 / 3.736 GB, free: 0.5078 MB / 442.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0003805/7.296, allocations: 107.2 kB / 3.736 GB, free: 428 kB / 442.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002995/7.299, allocations: 1.172 MB / 3.737 GB, free: 15.8 MB / 458.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.41e-05/7.299, allocations: 25.91 kB / 3.737 GB, free: 15.78 MB / 458.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002206/7.302, allocations: 2.343 MB / 3.74 GB, free: 13.66 MB / 458.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.569e-06/7.302, allocations: 4.062 kB / 3.74 GB, free: 13.66 MB / 458.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006743/7.308, allocations: 5.55 MB / 3.745 GB, free: 8.715 MB / 458.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003761/7.309, allocations: 248.7 kB / 3.745 GB, free: 8.477 MB / 458.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001706/7.309, allocations: 16 kB / 3.745 GB, free: 8.461 MB / 458.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006918/7.31, allocations: 77.52 kB / 3.745 GB, free: 8.41 MB / 458.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001105/7.31, allocations: 47.41 kB / 3.746 GB, free: 8.383 MB / 458.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.691e-05/7.31, allocations: 31.66 kB / 3.746 GB, free: 8.355 MB / 458.7 MB
Notification: Performance of sorting global known variables: time 0.0006124/7.31, allocations: 484.3 kB / 3.746 GB, free: 7.941 MB / 458.7 MB
Notification: Performance of sort global known variables: time 2.21e-07/7.31, allocations: 0 / 3.746 GB, free: 7.941 MB / 458.7 MB
Notification: Performance of remove unused functions: time 0.005463/7.316, allocations: 1.375 MB / 3.747 GB, free: 6.594 MB / 458.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 3 (evaporator.p,evaporator.V_l,controller.x)
 * Number of discrete variables: 27 ($cse1.region3boundary,$cse2.region3boundary,$cse4.phase,$cse4.region,$cse7.phase,$cse7.region,$cse9.phase,$cse9.region,$cse10.phase,$cse10.region,$cse11.phase,$cse11.region,$cse12.phase,$cse12.region,$whenCondition1,$whenCondition2,pump.medium.phase,q_F_Tab.a,q_F_Tab.b,q_F_Tab.last,q_F_Tab.nextEvent,q_F_Tab.nextEventScaled,Y_Valve_Tab.a,Y_Valve_Tab.b,Y_Valve_Tab.last,Y_Valve_Tab.nextEvent,Y_Valve_Tab.nextEventScaled)
 * Number of discrete states: 12 (Y_Valve_Tab.nextEvent,Y_Valve_Tab.last,Y_Valve_Tab.nextEventScaled,Y_Valve_Tab.b,Y_Valve_Tab.a,$whenCondition2,q_F_Tab.nextEvent,q_F_Tab.last,q_F_Tab.nextEventScaled,q_F_Tab.b,q_F_Tab.a,$whenCondition1)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (59):
 * Single equations (assignments): 48
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 8
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {2 6}
Notification: Performance of Backend phase and start with SimCode phase: time 0.00765/7.324, allocations: 1.771 MB / 3.749 GB, free: 5.219 MB / 458.7 MB
Notification: Performance of simCode: created initialization part: time 0.003356/7.327, allocations: 1.84 MB / 3.751 GB, free: 3.516 MB / 458.7 MB
Notification: Performance of simCode: created event and clocks part: time 4.048e-06/7.327, allocations: 4 kB / 3.751 GB, free: 3.512 MB / 458.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.001368/7.328, allocations: 0.901 MB / 3.752 GB, free: 2.66 MB / 458.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001798/7.33, allocations: 311.7 kB / 3.752 GB, free: 2.438 MB / 458.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2269/7.557, allocations: 2.762 MB / 3.755 GB, free: 60.99 MB / 458.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006207/7.558, allocations: 1.075 MB / 3.756 GB, free: 60.29 MB / 458.7 MB
Notification: Performance of simCode: alias equations: time 0.001115/7.559, allocations: 0.595 MB / 3.756 GB, free: 60.28 MB / 458.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001388/7.559, allocations: 60.25 kB / 3.756 GB, free: 60.28 MB / 458.7 MB
Notification: Performance of SimCode: time 9.52e-07/7.559, allocations: 3.688 kB / 3.756 GB, free: 60.28 MB / 458.7 MB
Notification: Performance of Templates: time 0.06332/7.622, allocations: 49.78 MB / 3.805 GB, free: 58.72 MB / 458.7 MB
make -j1 -f Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler.makefile
(rm -f Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler.pipe ; mkfifo Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler.pipe ; head -c 1048576 < Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler.pipe >> ../files/Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler.sim & ./Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler -abortSlowSimulation -alarm=480   -emit_protected -lv LOG_STATS > Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler.pipe 2>&1)
diffSimulationResults("Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v3.2.3+build.4/Modelica/Fluid/Examples/DrumBoiler/DrumBoiler/DrumBoiler.csv","../files/Modelica_3.2.3_Modelica.Fluid.Examples.DrumBoiler.DrumBoiler.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches