Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001415/0.001415, allocations: 113.9 kB / 18.94 MB, free: 2.93 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001822/0.001822, allocations: 191.1 kB / 22.23 MB, free: 5.105 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.441/1.441, allocations: 225.6 MB / 251 MB, free: 13.02 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.9022/0.9022, allocations: 134 MB / 440.3 MB, free: 216 kB / 334.1 MB " [Timeout remaining time 179] Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/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.Actuators.Valves.Validation.ThreeWayValveParameterization,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization") translateModel(IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 0.002023/0.002023, allocations: 68.92 kB / 0.6107 GB, free: 13.65 MB / 446.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1882/0.1903, allocations: 84.73 MB / 0.6935 GB, free: 8.996 MB / 0.5137 GB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization): time 0.5294/0.7196, allocations: 157.1 MB / 0.8469 GB, free: 11.29 MB / 0.6075 GB Notification: Performance of NFInst.instExpressions: time 0.05556/0.7752, allocations: 30.58 MB / 0.8767 GB, free: 12.64 MB / 0.6387 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.00961/0.7848, allocations: 198.2 kB / 0.8769 GB, free: 12.44 MB / 0.6387 GB Notification: Performance of NFTyping.typeComponents: time 0.004709/0.7895, allocations: 1.059 MB / 0.878 GB, free: 11.38 MB / 0.6387 GB Notification: Performance of NFTyping.typeBindings: time 0.01305/0.8025, allocations: 3.373 MB / 0.8813 GB, free: 7.988 MB / 0.6387 GB Notification: Performance of NFTyping.typeClassSections: time 0.007967/0.8105, allocations: 2.572 MB / 0.8838 GB, free: 5.469 MB / 0.6387 GB Notification: Performance of NFFlatten.flatten: time 0.01037/0.8209, allocations: 5.432 MB / 0.8891 GB, free: 20 kB / 0.6387 GB Notification: Performance of NFFlatten.resolveConnections: time 0.004646/0.8255, allocations: 1.855 MB / 0.8909 GB, free: 14.11 MB / 0.6544 GB Notification: Performance of NFEvalConstants.evaluate: time 0.008537/0.8341, allocations: 2.802 MB / 0.8936 GB, free: 11.3 MB / 0.6544 GB Notification: Performance of NFSimplifyModel.simplify: time 0.00502/0.8391, allocations: 2.054 MB / 0.8956 GB, free: 9.234 MB / 0.6544 GB Notification: Performance of NFPackage.collectConstants: time 0.001188/0.8403, allocations: 216 kB / 0.8958 GB, free: 9.023 MB / 0.6544 GB Notification: Performance of NFFlatten.collectFunctions: time 0.003809/0.8441, allocations: 1.116 MB / 0.8969 GB, free: 7.906 MB / 0.6544 GB Notification: Performance of NFScalarize.scalarize: time 0.001259/0.8453, allocations: 0.5796 MB / 0.8975 GB, free: 7.324 MB / 0.6544 GB Notification: Performance of NFVerifyModel.verify: time 0.003065/0.8484, allocations: 1.263 MB / 0.8987 GB, free: 6.055 MB / 0.6544 GB Notification: Performance of NFConvertDAE.convert: time 0.007167/0.8556, allocations: 3.373 MB / 0.902 GB, free: 2.672 MB / 0.6544 GB Notification: Performance of FrontEnd - DAE generated: time 9.909e-06/0.8556, allocations: 4 kB / 0.902 GB, free: 2.668 MB / 0.6544 GB Notification: Performance of FrontEnd: time 2.855e-06/0.8556, allocations: 0 / 0.902 GB, free: 2.668 MB / 0.6544 GB Notification: Performance of Transformations before backend: time 0.0001618/0.8557, allocations: 0 / 0.902 GB, free: 2.668 MB / 0.6544 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 297 * Number of variables: 297 Notification: Performance of Generate backend data structure: time 0.007587/0.8633, allocations: 2.722 MB / 0.9047 GB, free: 15.89 MB / 0.67 GB Notification: Performance of prepare preOptimizeDAE: time 5.897e-05/0.8634, allocations: 12.03 kB / 0.9047 GB, free: 15.88 MB / 0.67 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0006407/0.864, allocations: 278.3 kB / 0.905 GB, free: 15.61 MB / 0.67 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002817/0.8668, allocations: 1.445 MB / 0.9064 GB, free: 14.1 MB / 0.67 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.475e-05/0.8669, allocations: 102.3 kB / 0.9065 GB, free: 14 MB / 0.67 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002338/0.8672, allocations: 136 kB / 0.9066 GB, free: 13.87 MB / 0.67 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002377/0.8695, allocations: 1.183 MB / 0.9078 GB, free: 12.66 MB / 0.67 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.322e-05/0.8696, allocations: 1.125 kB / 0.9078 GB, free: 12.66 MB / 0.67 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001118/0.8697, allocations: 44 kB / 0.9078 GB, free: 12.61 MB / 0.67 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.266e-05/0.8697, allocations: 28 kB / 0.9078 GB, free: 12.59 MB / 0.67 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001942/0.8717, allocations: 1.055 MB / 0.9089 GB, free: 11.52 MB / 0.67 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.0127/0.8844, allocations: 6.267 MB / 0.915 GB, free: 4.793 MB / 0.67 GB Notification: Performance of preOpt comSubExp (simulation): time 0.001044/0.8854, allocations: 0.5436 MB / 0.9155 GB, free: 4.238 MB / 0.67 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0006222/0.886, allocations: 359.8 kB / 0.9158 GB, free: 3.887 MB / 0.67 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0002365/0.8863, allocations: 56.44 kB / 0.9159 GB, free: 3.832 MB / 0.67 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.811e-05/0.8863, allocations: 43.06 kB / 0.9159 GB, free: 3.781 MB / 0.67 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.001902/0.8882, allocations: 319.2 kB / 0.9162 GB, free: 3.469 MB / 0.67 GB Notification: Performance of pre-optimization done (n=58): time 3.006e-06/0.8882, allocations: 0 / 0.9162 GB, free: 3.469 MB / 0.67 GB Notification: Performance of matching and sorting (n=58): time 0.002419/0.8906, allocations: 1.175 MB / 0.9174 GB, free: 2.285 MB / 0.67 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.508e-05/0.8907, allocations: 63.84 kB / 0.9175 GB, free: 2.211 MB / 0.67 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002812/0.8935, allocations: 1.896 MB / 0.9193 GB, free: 296 kB / 0.67 GB Notification: Performance of collectPreVariables (initialization): time 0.0001609/0.8936, allocations: 45.7 kB / 0.9194 GB, free: 244 kB / 0.67 GB Notification: Performance of collectInitialEqns (initialization): time 0.0009995/0.8946, allocations: 0.9354 MB / 0.9203 GB, free: 15.29 MB / 0.6856 GB Notification: Performance of collectInitialBindings (initialization): time 0.0002222/0.8949, allocations: 214.1 kB / 0.9205 GB, free: 15.08 MB / 0.6856 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004924/0.8954, allocations: 302.7 kB / 0.9208 GB, free: 14.78 MB / 0.6856 GB Notification: Performance of setup shared object (initialization): time 0.0001945/0.8956, allocations: 349.9 kB / 0.9211 GB, free: 14.43 MB / 0.6856 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009077/0.8965, allocations: 449.9 kB / 0.9215 GB, free: 13.99 MB / 0.6856 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001343/0.8978, allocations: 0.6996 MB / 0.9222 GB, free: 13.21 MB / 0.6856 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.00186/0.8997, allocations: 0.981 MB / 0.9232 GB, free: 12.18 MB / 0.6856 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.646e-06/0.8997, allocations: 8 kB / 0.9232 GB, free: 12.18 MB / 0.6856 GB Notification: Performance of matching and sorting (n=150) (initialization): time 0.003242/0.9029, allocations: 1.433 MB / 0.9246 GB, free: 10.73 MB / 0.6856 GB Notification: Performance of prepare postOptimizeDAE: time 2.984e-05/0.9029, allocations: 8 kB / 0.9246 GB, free: 10.73 MB / 0.6856 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.379e-05/0.903, allocations: 4.375 kB / 0.9246 GB, free: 10.72 MB / 0.6856 GB Notification: Performance of postOpt tearingSystem (initialization): time 3.808e-05/0.903, allocations: 12 kB / 0.9246 GB, free: 10.71 MB / 0.6856 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001366/0.9044, allocations: 295.5 kB / 0.9249 GB, free: 10.42 MB / 0.6856 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.182e-05/0.9044, allocations: 12 kB / 0.9249 GB, free: 10.41 MB / 0.6856 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001884/0.9063, allocations: 79.88 kB / 0.925 GB, free: 10.33 MB / 0.6856 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001458/0.9064, allocations: 60 kB / 0.925 GB, free: 10.27 MB / 0.6856 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001609/0.908, allocations: 0.7212 MB / 0.9257 GB, free: 9.547 MB / 0.6856 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001087/0.9091, allocations: 0.6645 MB / 0.9264 GB, free: 8.809 MB / 0.6856 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001652/0.9108, allocations: 0.942 MB / 0.9273 GB, free: 7.828 MB / 0.6856 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.238e-06/0.9108, allocations: 0 / 0.9273 GB, free: 7.828 MB / 0.6856 GB Notification: Performance of matching and sorting (n=150) (initialization_lambda0): time 0.00294/0.9137, allocations: 1.386 MB / 0.9286 GB, free: 6.434 MB / 0.6856 GB Notification: Performance of prepare postOptimizeDAE: time 1.601e-05/0.9137, allocations: 7.938 kB / 0.9287 GB, free: 6.426 MB / 0.6856 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.466e-06/0.9137, allocations: 4 kB / 0.9287 GB, free: 6.422 MB / 0.6856 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.075e-05/0.9138, allocations: 11.94 kB / 0.9287 GB, free: 6.41 MB / 0.6856 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001305/0.9151, allocations: 288 kB / 0.9289 GB, free: 6.129 MB / 0.6856 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.072e-05/0.9151, allocations: 15.88 kB / 0.929 GB, free: 6.113 MB / 0.6856 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00194/0.917, allocations: 95.86 kB / 0.929 GB, free: 6.02 MB / 0.6856 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001293/0.9171, allocations: 59.95 kB / 0.9291 GB, free: 5.961 MB / 0.6856 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 14 * 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 (150): * Single equations (assignments): 150 * 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.0004722/0.9176, allocations: 241.7 kB / 0.9293 GB, free: 5.719 MB / 0.6856 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004313/0.918, allocations: 210.6 kB / 0.9295 GB, free: 5.512 MB / 0.6856 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00243/0.9205, allocations: 1.094 MB / 0.9306 GB, free: 4.41 MB / 0.6856 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.732e-05/0.9205, allocations: 11.94 kB / 0.9306 GB, free: 4.398 MB / 0.6856 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 6.862e-06/0.9205, allocations: 0 / 0.9306 GB, free: 4.398 MB / 0.6856 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.929e-06/0.9205, allocations: 7.984 kB / 0.9306 GB, free: 4.391 MB / 0.6856 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004377/0.9249, allocations: 2.424 MB / 0.933 GB, free: 1.895 MB / 0.6856 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.939e-06/0.9249, allocations: 4 kB / 0.933 GB, free: 1.891 MB / 0.6856 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000666/0.9256, allocations: 135.8 kB / 0.9331 GB, free: 1.758 MB / 0.6856 GB Notification: Performance of postOpt tearingSystem (simulation): time 1.217e-05/0.9256, allocations: 4 kB / 0.9331 GB, free: 1.754 MB / 0.6856 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.604e-05/0.9256, allocations: 19.98 kB / 0.9331 GB, free: 1.734 MB / 0.6856 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 9.878e-06/0.9256, allocations: 8.125 kB / 0.9332 GB, free: 1.727 MB / 0.6856 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.194e-06/0.9256, allocations: 4 kB / 0.9332 GB, free: 1.723 MB / 0.6856 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001927/0.9276, allocations: 1.091 MB / 0.9342 GB, free: 0.5977 MB / 0.6856 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0008007/0.9284, allocations: 287 kB / 0.9345 GB, free: 320 kB / 0.6856 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003859/0.9288, allocations: 27.92 kB / 0.9345 GB, free: 292 kB / 0.6856 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001021/0.9298, allocations: 31.97 kB / 0.9346 GB, free: 260 kB / 0.6856 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001467/0.9299, allocations: 52.56 kB / 0.9346 GB, free: 208 kB / 0.6856 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.227e-05/0.93, allocations: 35.92 kB / 0.9346 GB, free: 172 kB / 0.6856 GB Notification: Performance of sorting global known variables: time 0.00253/0.9325, allocations: 1.248 MB / 0.9359 GB, free: 14.91 MB / 0.7012 GB Notification: Performance of sort global known variables: time 1.4e-07/0.9325, allocations: 3.938 kB / 0.9359 GB, free: 14.9 MB / 0.7012 GB Notification: Performance of remove unused functions: time 0.003476/0.936, allocations: 0.9163 MB / 0.9368 GB, free: 13.98 MB / 0.7012 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 7 * 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 simulation (77): * Single equations (assignments): 74 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 3 * 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.001015/0.937, allocations: 340.1 kB / 0.9371 GB, free: 13.66 MB / 0.7012 GB Notification: Performance of simCode: created initialization part: time 0.003789/0.9408, allocations: 1.524 MB / 0.9386 GB, free: 12.14 MB / 0.7012 GB Notification: Performance of simCode: created event and clocks part: time 4.689e-06/0.9408, allocations: 0 / 0.9386 GB, free: 12.14 MB / 0.7012 GB Notification: Performance of simCode: created simulation system equations: time 0.0007396/0.9415, allocations: 371.5 kB / 0.9389 GB, free: 11.77 MB / 0.7012 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005966/0.9475, allocations: 1.091 MB / 0.94 GB, free: 10.74 MB / 0.7012 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006928/0.9544, allocations: 3.053 MB / 0.943 GB, free: 7.633 MB / 0.7012 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001931/0.9564, allocations: 1.405 MB / 0.9443 GB, free: 6.195 MB / 0.7012 GB Notification: Performance of simCode: alias equations: time 0.002446/0.9588, allocations: 408.8 kB / 0.9447 GB, free: 5.801 MB / 0.7012 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000694/0.9595, allocations: 163.4 kB / 0.9449 GB, free: 5.641 MB / 0.7012 GB Notification: Performance of SimCode: time 1.503e-06/0.9595, allocations: 0 / 0.9449 GB, free: 5.641 MB / 0.7012 GB Notification: Performance of Templates: time 0.07892/1.038, allocations: 39.44 MB / 0.9834 GB, free: 14.59 MB / 0.7481 GB " [Timeout remaining time 659] make -j1 -f IDEAS_IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization.makefile [Timeout 660] (rm -f IDEAS_IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization.pipe ; mkfifo IDEAS_IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization.pipe >> ../files/IDEAS_IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization.sim & ./IDEAS_IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Fluid.Actuators.Valves.Validation.ThreeWayValveParameterization.pipe 2>&1) [Timeout 480] [Calling sys.exit(0), Time elapsed: 7.82562718167901] Failed to read output from testmodel.py, exit status != 0: 1.0474166311323643 1.064427115 0.20506920399999995 Calling exit ... <OMPython.OMCSessionZMQ object at 0x7fbc04a097b0>