Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001004/0.001004, allocations: 73.88 kB / 20.65 MB, free: 3.844 MB / 18.57 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001743/0.001743, allocations: 169 kB / 24.06 MB, free: 452 kB / 18.57 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.051/1.051, allocations: 177.1 MB / 204.5 MB, free: 5.488 MB / 186.7 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo", uses=false) [Timeout 180] "[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Examples/PPD12/Structure.mo:531:21-535:34:writable] Warning: Lexer treating \\ as \\\\, since \\e is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Examples/PPD12/Structure.mo:531:21-535:42:writable] Warning: Lexer treating \\ as \\\\, since \\< is not a valid Modelica escape sequence. Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo): time 0.8948/0.8948, allocations: 154.9 MB / 415.9 MB, free: 264 kB / 378.7 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Utilities/Cryptographics/BaseClasses/sha.mo:2:1-19:8:writable] Warning: External function annotation should occur on the external-clause, not on the function. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Utilities/File/sha2.mo:2:1-9:9:writable] Warning: External function annotation should occur on the external-clause, not on the function. " [Timeout remaining time 179] Using package IDEAS with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: translateModel(IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource") translateModel(IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 1.784e-06/1.784e-06, allocations: 0 / 0.5219 GB, free: 1.543 MB / 490.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 2.268e-05/2.447e-05, allocations: 2.312 kB / 0.5219 GB, free: 1.539 MB / 490.7 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource): time 0.1595/0.1595, allocations: 158.3 MB / 0.6764 GB, free: 2.891 MB / 0.6355 GB Notification: Performance of NFInst.instExpressions: time 0.2924/0.4519, allocations: 8.331 MB / 0.6846 GB, free: 49.66 MB / 0.6355 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.002518/0.4544, allocations: 95.31 kB / 0.6847 GB, free: 49.66 MB / 0.6355 GB Notification: Performance of NFTyping.typeComponents: time 0.001703/0.4561, allocations: 0.7744 MB / 0.6854 GB, free: 49.65 MB / 0.6355 GB Notification: Performance of NFTyping.typeBindings: time 0.004684/0.4608, allocations: 2.401 MB / 0.6878 GB, free: 49.57 MB / 0.6355 GB Notification: Performance of NFTyping.typeClassSections: time 0.003341/0.4641, allocations: 1.565 MB / 0.6893 GB, free: 49.54 MB / 0.6355 GB Notification: Performance of NFFlatten.flatten: time 0.006675/0.4708, allocations: 4.206 MB / 0.6934 GB, free: 49.11 MB / 0.6355 GB Notification: Performance of NFFlatten.resolveConnections: time 0.002369/0.4732, allocations: 1.192 MB / 0.6946 GB, free: 48.98 MB / 0.6355 GB Notification: Performance of NFEvalConstants.evaluate: time 0.004973/0.4782, allocations: 2.211 MB / 0.6967 GB, free: 48.78 MB / 0.6355 GB Notification: Performance of NFSimplifyModel.simplify: time 0.002223/0.4804, allocations: 1.235 MB / 0.6979 GB, free: 48.63 MB / 0.6355 GB Notification: Performance of NFPackage.collectConstants: time 0.0004793/0.4809, allocations: 174.1 kB / 0.6981 GB, free: 48.63 MB / 0.6355 GB Notification: Performance of NFFlatten.collectFunctions: time 0.002467/0.4833, allocations: 1.284 MB / 0.6994 GB, free: 48.57 MB / 0.6355 GB Notification: Performance of NFScalarize.scalarize: time 0.0007117/0.484, allocations: 1.02 MB / 0.7003 GB, free: 48.45 MB / 0.6355 GB Notification: Performance of NFVerifyModel.verify: time 0.001918/0.486, allocations: 0.8744 MB / 0.7012 GB, free: 48.33 MB / 0.6355 GB Notification: Performance of NFConvertDAE.convert: time 0.006961/0.4929, allocations: 2.733 MB / 0.7039 GB, free: 47.95 MB / 0.6355 GB Notification: Performance of FrontEnd - DAE generated: time 5.46e-06/0.4929, allocations: 0 / 0.7039 GB, free: 47.95 MB / 0.6355 GB Notification: Performance of FrontEnd: time 1.363e-06/0.4929, allocations: 0.8438 kB / 0.7039 GB, free: 47.95 MB / 0.6355 GB Notification: Performance of Transformations before backend: time 0.0001175/0.493, allocations: 0 / 0.7039 GB, free: 47.95 MB / 0.6355 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 281 * Number of variables: 281 Notification: Performance of Generate backend data structure: time 0.006353/0.4994, allocations: 3.156 MB / 0.707 GB, free: 46.29 MB / 0.6355 GB Notification: Performance of prepare preOptimizeDAE: time 3.547e-05/0.4994, allocations: 10.16 kB / 0.707 GB, free: 46.29 MB / 0.6355 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002165/0.5016, allocations: 0.7967 MB / 0.7077 GB, free: 46.11 MB / 0.6355 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.00219/0.5038, allocations: 1.706 MB / 0.7094 GB, free: 45.54 MB / 0.6355 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.088e-05/0.5039, allocations: 144 kB / 0.7095 GB, free: 45.48 MB / 0.6355 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001213/0.504, allocations: 117.9 kB / 0.7097 GB, free: 45.48 MB / 0.6355 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.001358/0.5054, allocations: 1.154 MB / 0.7108 GB, free: 45.03 MB / 0.6355 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.214e-05/0.5054, allocations: 0 / 0.7108 GB, free: 45.03 MB / 0.6355 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.531e-05/0.5055, allocations: 51 kB / 0.7108 GB, free: 45.03 MB / 0.6355 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.356e-05/0.5055, allocations: 39.95 kB / 0.7109 GB, free: 45.02 MB / 0.6355 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.000762/0.5063, allocations: 0.5924 MB / 0.7114 GB, free: 44.92 MB / 0.6355 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.008238/0.5145, allocations: 5.021 MB / 0.7164 GB, free: 42.95 MB / 0.6355 GB Notification: Performance of preOpt comSubExp (simulation): time 0.001466/0.516, allocations: 0.5443 MB / 0.7169 GB, free: 42.85 MB / 0.6355 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0005832/0.5166, allocations: 327.2 kB / 0.7172 GB, free: 42.77 MB / 0.6355 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0004047/0.517, allocations: 117.8 kB / 0.7173 GB, free: 42.77 MB / 0.6355 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0008181/0.5178, allocations: 0.5402 MB / 0.7178 GB, free: 42.46 MB / 0.6355 GB Notification: Performance of pre-optimization done (n=89): time 7.474e-06/0.5178, allocations: 0.7812 kB / 0.7178 GB, free: 42.46 MB / 0.6355 GB Notification: Performance of matching and sorting (n=89): time 0.009407/0.5272, allocations: 2.498 MB / 0.7203 GB, free: 42.06 MB / 0.6355 GB Notification: Performance of inlineWhenForInitialization (initialization): time 4.679e-05/0.5272, allocations: 148.4 kB / 0.7204 GB, free: 41.9 MB / 0.6355 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002516/0.5298, allocations: 2.17 MB / 0.7225 GB, free: 41.6 MB / 0.6355 GB Notification: Performance of collectPreVariables (initialization): time 0.0001108/0.5299, allocations: 43.61 kB / 0.7226 GB, free: 41.57 MB / 0.6355 GB Notification: Performance of collectInitialEqns (initialization): time 0.0007439/0.5306, allocations: 1.173 MB / 0.7237 GB, free: 41.23 MB / 0.6355 GB Notification: Performance of collectInitialBindings (initialization): time 0.0002375/0.5309, allocations: 306.5 kB / 0.724 GB, free: 41.03 MB / 0.6355 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002894/0.5311, allocations: 227.6 kB / 0.7242 GB, free: 41 MB / 0.6355 GB Notification: Performance of setup shared object (initialization): time 7.545e-05/0.5312, allocations: 0.5188 MB / 0.7247 GB, free: 40.52 MB / 0.6355 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004182/0.5316, allocations: 252.4 kB / 0.725 GB, free: 40.46 MB / 0.6355 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005451/0.5322, allocations: 0.7445 MB / 0.7257 GB, free: 39.82 MB / 0.6355 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.0008298/0.533, allocations: 0.7683 MB / 0.7265 GB, free: 39.45 MB / 0.6355 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.446e-06/0.533, allocations: 1.406 kB / 0.7265 GB, free: 39.45 MB / 0.6355 GB Notification: Performance of matching and sorting (n=131) (initialization): time 0.001839/0.5349, allocations: 1.207 MB / 0.7276 GB, free: 39.11 MB / 0.6355 GB Notification: Performance of prepare postOptimizeDAE: time 5.029e-05/0.5349, allocations: 74.84 kB / 0.7277 GB, free: 39.05 MB / 0.6355 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.242e-05/0.5349, allocations: 4.594 kB / 0.7277 GB, free: 39.05 MB / 0.6355 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.001367/0.5363, allocations: 0.584 MB / 0.7283 GB, free: 39.01 MB / 0.6355 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005609/0.5368, allocations: 189.8 kB / 0.7285 GB, free: 39.01 MB / 0.6355 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00146/0.5383, allocations: 2.993 MB / 0.7314 GB, free: 36.48 MB / 0.6355 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009972/0.5393, allocations: 145.3 kB / 0.7315 GB, free: 36.44 MB / 0.6355 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.331e-05/0.5394, allocations: 47.53 kB / 0.7316 GB, free: 36.43 MB / 0.6355 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 20 * Number of states: 0 () * Number of discrete variables: 17 (THotIn_set.nextEventScaled,THotIn_set.nextEvent,$PRE.THotIn_set.nextEvent,THotIn_set.last,THotIn_set.b,THotIn_set.a,mHot_flow_set.nextEventScaled,mHot_flow_set.nextEvent,$PRE.mHot_flow_set.nextEvent,mHot_flow_set.last,mHot_flow_set.b,mHot_flow_set.a,orc.cyc.hys.y,$PRE.orc.cyc.hys.y,orc.on_actual,$whenCondition2,$whenCondition1) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (90): * Single equations (assignments): 85 * Array equations: 1 * Algorithm blocks: 2 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 1 system {(1,1,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(4,26)} Notification: Performance of prepare postOptimizeDAE: time 0.0004976/0.5399, allocations: 292 kB / 0.7318 GB, free: 36.2 MB / 0.6355 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002847/0.5402, allocations: 266.4 kB / 0.7321 GB, free: 36.07 MB / 0.6355 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001903/0.5421, allocations: 1.221 MB / 0.7333 GB, free: 35.82 MB / 0.6355 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.392e-05/0.5421, allocations: 11.44 kB / 0.7333 GB, free: 35.82 MB / 0.6355 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 2.986e-06/0.5421, allocations: 0 / 0.7333 GB, free: 35.82 MB / 0.6355 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.027e-05/0.5421, allocations: 4.031 kB / 0.7333 GB, free: 35.82 MB / 0.6355 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003943/0.546, allocations: 2.661 MB / 0.7359 GB, free: 35.17 MB / 0.6355 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.959e-06/0.546, allocations: 3.781 kB / 0.7359 GB, free: 35.17 MB / 0.6355 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0003733/0.5464, allocations: 116 kB / 0.736 GB, free: 35.17 MB / 0.6355 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.00105/0.5475, allocations: 0.5807 MB / 0.7366 GB, free: 35.13 MB / 0.6355 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.403e-05/0.5475, allocations: 30.73 kB / 0.7366 GB, free: 35.13 MB / 0.6355 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001238/0.5488, allocations: 2.985 MB / 0.7395 GB, free: 32.61 MB / 0.6355 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.876e-06/0.5488, allocations: 6.469 kB / 0.7395 GB, free: 32.6 MB / 0.6355 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001742/0.5505, allocations: 1.406 MB / 0.7409 GB, free: 31.96 MB / 0.6355 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0005706/0.5511, allocations: 397.8 kB / 0.7413 GB, free: 31.83 MB / 0.6355 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002015/0.5513, allocations: 23.25 kB / 0.7413 GB, free: 31.83 MB / 0.6355 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005913/0.5519, allocations: 74.23 kB / 0.7414 GB, free: 31.83 MB / 0.6355 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001128/0.552, allocations: 75.92 kB / 0.7415 GB, free: 31.82 MB / 0.6355 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.134e-05/0.5521, allocations: 39.06 kB / 0.7415 GB, free: 31.82 MB / 0.6355 GB Notification: Performance of sorting global known variables: time 0.001048/0.5531, allocations: 1.274 MB / 0.7427 GB, free: 31.64 MB / 0.6355 GB Notification: Performance of sort global known variables: time 1.6e-07/0.5531, allocations: 3 kB / 0.7427 GB, free: 31.64 MB / 0.6355 GB Notification: Performance of remove unused functions: time 0.001479/0.5546, allocations: 0.6853 MB / 0.7434 GB, free: 31.55 MB / 0.6355 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 12 * Number of states: 0 () * Number of discrete variables: 14 ($whenCondition1,$whenCondition2,orc.on_actual,orc.cyc.hys.y,mHot_flow_set.a,mHot_flow_set.b,mHot_flow_set.last,mHot_flow_set.nextEvent,mHot_flow_set.nextEventScaled,THotIn_set.a,THotIn_set.b,THotIn_set.last,THotIn_set.nextEvent,THotIn_set.nextEventScaled) * Number of discrete states: 13 (THotIn_set.nextEvent,THotIn_set.last,THotIn_set.nextEventScaled,THotIn_set.b,THotIn_set.a,$whenCondition2,mHot_flow_set.nextEvent,mHot_flow_set.last,mHot_flow_set.nextEventScaled,mHot_flow_set.b,mHot_flow_set.a,$whenCondition1,orc.cyc.hys.y) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (54): * Single equations (assignments): 45 * Array equations: 0 * Algorithm blocks: 2 * Record equations: 5 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 1 system {(1,1,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(4,26)} Notification: Performance of Backend phase and start with SimCode phase: time 0.0005827/0.5552, allocations: 388.7 kB / 0.7438 GB, free: 31.43 MB / 0.6355 GB Notification: Performance of simCode: created initialization part: time 0.001327/0.5565, allocations: 1.072 MB / 0.7448 GB, free: 30.97 MB / 0.6355 GB Notification: Performance of simCode: created event and clocks part: time 4.538e-06/0.5565, allocations: 3.25 kB / 0.7448 GB, free: 30.97 MB / 0.6355 GB Notification: Performance of simCode: created simulation system equations: time 0.000647/0.5571, allocations: 0.692 MB / 0.7455 GB, free: 30.59 MB / 0.6355 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002025/0.5592, allocations: 0.8517 MB / 0.7463 GB, free: 30.44 MB / 0.6355 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005032/0.5642, allocations: 3.812 MB / 0.7501 GB, free: 28.65 MB / 0.6355 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0003567/0.5646, allocations: 496.8 kB / 0.7505 GB, free: 28.55 MB / 0.6355 GB Notification: Performance of simCode: alias equations: time 0.0008849/0.5654, allocations: 275.8 kB / 0.7508 GB, free: 28.48 MB / 0.6355 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001264/0.5667, allocations: 0.7685 MB / 0.7515 GB, free: 28.41 MB / 0.6355 GB Notification: Performance of SimCode: time 1.443e-06/0.5667, allocations: 0 / 0.7515 GB, free: 28.41 MB / 0.6355 GB Notification: Performance of Templates: time 0.04829/0.615, allocations: 45.18 MB / 0.7957 GB, free: 9.555 MB / 0.6355 GB " [Timeout remaining time 659] make -j1 -f IDEAS_dev_IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource.makefile [Timeout 660] (rm -f IDEAS_dev_IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource.sim & ./IDEAS_dev_IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource -abortSlowSimulation -alarm=240 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.CHPs.OrganicRankine.Validation.VariableSource.pipe 2>&1) [Timeout 240] [Calling sys.exit(0), Time elapsed: 5.5562809756956995]