Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpWithPulseControl.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: translateModel(IDEAS.Fluid.Movers.Examples.PumpWithPulseControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpWithPulseControl")
translateModel(IDEAS.Fluid.Movers.Examples.PumpWithPulseControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpWithPulseControl")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001542/0.001542, allocations: 107.8 kB / 16.41 MB, free: 6.449 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.001758/0.001758, allocations: 192.3 kB / 17.35 MB, free: 5.707 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.323/1.323, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.7851/0.7851, allocations: 135.1 MB / 426.3 MB, free: 4.133 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001239/0.001239, allocations: 67.14 kB / 0.5863 GB, free: 21.71 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1241/0.1254, allocations: 80.92 MB / 0.6653 GB, free: 5.84 MB / 0.4981 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pump.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Movers.Examples.PumpWithPulseControl): time 0.0286/0.154, allocations: 30.58 MB / 0.6952 GB, free: 7.148 MB / 0.5294 GB
Notification: Performance of NFInst.instExpressions: time 0.01289/0.1669, allocations: 10.22 MB / 0.7051 GB, free: 12.9 MB / 0.545 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001144/0.1681, allocations: 47.75 kB / 0.7052 GB, free: 12.86 MB / 0.545 GB
Notification: Performance of NFTyping.typeComponents: time 0.001724/0.1698, allocations: 0.6913 MB / 0.7059 GB, free: 12.16 MB / 0.545 GB
Notification: Performance of NFTyping.typeBindings: time 0.003165/0.173, allocations: 1.493 MB / 0.7073 GB, free: 10.66 MB / 0.545 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002698/0.1757, allocations: 1.31 MB / 0.7086 GB, free: 9.359 MB / 0.545 GB
Notification: Performance of NFFlatten.flatten: time 0.003264/0.179, allocations: 2.893 MB / 0.7114 GB, free: 6.453 MB / 0.545 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0013/0.1803, allocations: 0.9254 MB / 0.7123 GB, free: 5.516 MB / 0.545 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00237/0.1827, allocations: 1.161 MB / 0.7135 GB, free: 4.355 MB / 0.545 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001142/0.1838, allocations: 0.7778 MB / 0.7142 GB, free: 3.574 MB / 0.545 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002156/0.1841, allocations: 96 kB / 0.7143 GB, free: 3.48 MB / 0.545 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00159/0.1857, allocations: 0.7997 MB / 0.7151 GB, free: 2.68 MB / 0.545 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003922/0.1861, allocations: 331 kB / 0.7154 GB, free: 2.355 MB / 0.545 GB
Notification: Performance of NFVerifyModel.verify: time 0.0007137/0.1868, allocations: 0.5791 MB / 0.716 GB, free: 1.773 MB / 0.545 GB
Notification: Performance of NFConvertDAE.convert: time 0.002484/0.1893, allocations: 1.904 MB / 0.7178 GB, free: 15.86 MB / 0.5606 GB
Notification: Performance of FrontEnd - DAE generated: time 3.597e-06/0.1893, allocations: 0 / 0.7178 GB, free: 15.86 MB / 0.5606 GB
Notification: Performance of FrontEnd: time 1.273e-06/0.1893, allocations: 0 / 0.7178 GB, free: 15.86 MB / 0.5606 GB
Notification: Performance of Transformations before backend: time 1.728e-05/0.1893, allocations: 3.938 kB / 0.7178 GB, free: 15.86 MB / 0.5606 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 150
 * Number of variables: 150
Notification: Performance of Generate backend data structure: time 0.002236/0.1916, allocations: 1.538 MB / 0.7193 GB, free: 14.26 MB / 0.5606 GB
Notification: Performance of prepare preOptimizeDAE: time 3.332e-05/0.1916, allocations: 9.109 kB / 0.7193 GB, free: 14.25 MB / 0.5606 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0009144/0.1925, allocations: 212 kB / 0.7196 GB, free: 14.05 MB / 0.5606 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001607/0.1941, allocations: 1.012 MB / 0.7205 GB, free: 12.99 MB / 0.5606 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.614e-05/0.1942, allocations: 49.31 kB / 0.7206 GB, free: 12.94 MB / 0.5606 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 9.849e-05/0.1943, allocations: 68 kB / 0.7207 GB, free: 12.88 MB / 0.5606 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001188/0.1955, allocations: 0.6981 MB / 0.7213 GB, free: 12.15 MB / 0.5606 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.96e-05/0.1955, allocations: 0 / 0.7213 GB, free: 12.15 MB / 0.5606 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.866e-05/0.1956, allocations: 28 kB / 0.7214 GB, free: 12.12 MB / 0.5606 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.296e-05/0.1956, allocations: 16 kB / 0.7214 GB, free: 12.11 MB / 0.5606 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001122/0.1967, allocations: 0.5165 MB / 0.7219 GB, free: 11.59 MB / 0.5606 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.003844/0.2006, allocations: 3.087 MB / 0.7249 GB, free: 8.32 MB / 0.5606 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.000909/0.2015, allocations: 370.7 kB / 0.7252 GB, free: 7.949 MB / 0.5606 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004324/0.202, allocations: 180.8 kB / 0.7254 GB, free: 7.77 MB / 0.5606 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001768/0.2037, allocations: 1.497 MB / 0.7269 GB, free: 6.098 MB / 0.5606 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0005188/0.2043, allocations: 247.4 kB / 0.7271 GB, free: 5.844 MB / 0.5606 GB
Notification: Performance of pre-optimization done (n=31): time 1.733e-06/0.2043, allocations: 0 / 0.7271 GB, free: 5.844 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=31): time 0.001327/0.2056, allocations: 0.5399 MB / 0.7276 GB, free: 5.297 MB / 0.5606 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.174e-05/0.2057, allocations: 59.34 kB / 0.7277 GB, free: 5.227 MB / 0.5606 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001021/0.2067, allocations: 0.9034 MB / 0.7286 GB, free: 4.301 MB / 0.5606 GB
Notification: Performance of collectPreVariables (initialization): time 4.273e-05/0.2067, allocations: 33.7 kB / 0.7286 GB, free: 4.262 MB / 0.5606 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000362/0.2071, allocations: 496.5 kB / 0.7291 GB, free: 3.773 MB / 0.5606 GB
Notification: Performance of collectInitialBindings (initialization): time 9.546e-05/0.2072, allocations: 107.1 kB / 0.7292 GB, free: 3.668 MB / 0.5606 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001761/0.2074, allocations: 126.1 kB / 0.7293 GB, free: 3.539 MB / 0.5606 GB
Notification: Performance of setup shared object (initialization): time 0.0001129/0.2075, allocations: 326 kB / 0.7296 GB, free: 3.215 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004565/0.208, allocations: 199 kB / 0.7298 GB, free: 3.016 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005937/0.2086, allocations: 410.1 kB / 0.7302 GB, free: 2.527 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001015/0.2096, allocations: 0.5984 MB / 0.7308 GB, free: 1.844 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.612e-06/0.2096, allocations: 7.938 kB / 0.7308 GB, free: 1.836 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=65) (initialization): time 0.001392/0.211, allocations: 0.7032 MB / 0.7315 GB, free: 1.121 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 3.568e-05/0.2111, allocations: 37.69 kB / 0.7315 GB, free: 1.078 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.315e-05/0.2111, allocations: 8.594 kB / 0.7315 GB, free: 1.07 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.354e-05/0.2111, allocations: 8 kB / 0.7315 GB, free: 1.062 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005057/0.2116, allocations: 131.8 kB / 0.7317 GB, free: 0.9336 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.812e-05/0.2116, allocations: 15.94 kB / 0.7317 GB, free: 0.918 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.000564/0.2122, allocations: 72.19 kB / 0.7317 GB, free: 0.8477 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.31e-05/0.2123, allocations: 31.98 kB / 0.7318 GB, free: 0.8164 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.000635/0.2129, allocations: 397.1 kB / 0.7322 GB, free: 432 kB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0005017/0.2134, allocations: 382.3 kB / 0.7325 GB, free: 15.96 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0008783/0.2143, allocations: 0.5463 MB / 0.7331 GB, free: 15.33 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.21e-06/0.2144, allocations: 4 kB / 0.7331 GB, free: 15.32 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=65) (initialization_lambda0): time 0.001185/0.2155, allocations: 0.6618 MB / 0.7337 GB, free: 14.65 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 2.756e-05/0.2156, allocations: 34.48 kB / 0.7337 GB, free: 14.61 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.685e-06/0.2156, allocations: 4 kB / 0.7337 GB, free: 14.61 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 8.546e-06/0.2156, allocations: 12 kB / 0.7337 GB, free: 14.59 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004304/0.216, allocations: 119.8 kB / 0.7339 GB, free: 14.48 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.235e-05/0.2161, allocations: 11.98 kB / 0.7339 GB, free: 14.46 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005062/0.2166, allocations: 60.31 kB / 0.7339 GB, free: 14.41 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.339e-05/0.2166, allocations: 31.97 kB / 0.734 GB, free: 14.38 MB / 0.5762 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 26
 * Number of states: 0 ()
 * Number of discrete variables: 5 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (63):
 * Single equations (assignments): 61
 * Array equations: 1
 * Algorithm blocks: 1
 * 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.0001694/0.2168, allocations: 220 kB / 0.7342 GB, free: 14.15 MB / 0.5762 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001213/0.2169, allocations: 99.39 kB / 0.7343 GB, free: 14.05 MB / 0.5762 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001316/0.2183, allocations: 0.5685 MB / 0.7348 GB, free: 13.48 MB / 0.5762 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0009751/0.2193, allocations: 0.6541 MB / 0.7355 GB, free: 12.75 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.438e-06/0.2193, allocations: 3.938 kB / 0.7355 GB, free: 12.75 MB / 0.5762 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000281/0.2196, allocations: 220.3 kB / 0.7357 GB, free: 12.52 MB / 0.5762 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001104/0.2197, allocations: 4 kB / 0.7357 GB, free: 12.51 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003882/0.2201, allocations: 27.97 kB / 0.7357 GB, free: 12.48 MB / 0.5762 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.484e-05/0.2202, allocations: 23.97 kB / 0.7357 GB, free: 12.46 MB / 0.5762 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.00127/0.2214, allocations: 0.5392 MB / 0.7363 GB, free: 11.91 MB / 0.5762 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001554/0.223, allocations: 0.9051 MB / 0.7371 GB, free: 10.99 MB / 0.5762 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0004235/0.2235, allocations: 214.4 kB / 0.7373 GB, free: 10.79 MB / 0.5762 GB
Notification: Performance of sorting global known variables: time 0.0007711/0.2242, allocations: 0.618 MB / 0.7379 GB, free: 10.16 MB / 0.5762 GB
Notification: Performance of Backend: time 2.955e-06/0.2242, allocations: 0 / 0.7379 GB, free: 10.16 MB / 0.5762 GB
Notification: Performance of simCode: created initialization part: time 0.002547/0.2268, allocations: 1.068 MB / 0.739 GB, free: 9.066 MB / 0.5762 GB
Notification: Performance of SimCode: time 0.00363/0.2304, allocations: 2.369 MB / 0.7413 GB, free: 6.645 MB / 0.5762 GB
Notification: Performance of Templates: time 0.3013/0.5318, allocations: 22.18 MB / 0.763 GB, free: 75.38 MB / 0.5762 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpWithPulseControl.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpWithPulseControl.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpWithPulseControl.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpWithPulseControl.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpWithPulseControl.sim & ./IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpWithPulseControl  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Movers.Examples.PumpWithPulseControl.pipe 2>&1)