Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.Controls.OBC.Utilities.Validation.OptimalStartCoolingNegativeStartTime.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.0005576/0.0005576, allocations: 84.23 kB / 20.06 MB, free: 4.465 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.000985/0.000985, allocations: 173.9 kB / 23.36 MB, free: 1.16 MB / 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 0.8458/0.8458, allocations: 177.1 MB / 203.7 MB, free: 5.699 MB / 186.7 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/package.mo", uses=false) [Timeout 180] "[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Examples/PPD12/Structure.mo:531:21-545:108:writable] Warning: Lexer treating \\ as \\\\, since \\e is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Examples/PPD12/Structure.mo:531:21-545:116:writable] Warning: Lexer treating \\ as \\\\, since \\< is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Media/Refrigerants/R410A/package.order:0:0-0:0:readonly] Warning: Found duplicate names in package.order file: A, B, C. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Media/Refrigerants/R410A/package.mo:2:1-70:10:writable] Warning: C was referenced in the package.order file, but was not found in package.mo, C/package.mo or C.mo. Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/package.mo): time 0.6687/0.6687, allocations: 154.6 MB / 414.7 MB, free: 0.75 MB / 378.7 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/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 4.0.0/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 4.0.0/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.Controls.OBC.Utilities.Validation.OptimalStartCoolingNegativeStartTime,tolerance=1e-07,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Controls.OBC.Utilities.Validation.OptimalStartCoolingNegativeStartTime") translateModel(IDEAS.Controls.OBC.Utilities.Validation.OptimalStartCoolingNegativeStartTime,tolerance=1e-07,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Controls.OBC.Utilities.Validation.OptimalStartCoolingNegativeStartTime") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 3.031e-05/3.031e-05, allocations: 2.312 kB / 0.6195 GB, free: 11.97 MB / 0.5417 GB Notification: Performance of NFInst.instantiate(IDEAS.Controls.OBC.Utilities.Validation.OptimalStartCoolingNegativeStartTime): time 0.004198/0.004228, allocations: 4.141 MB / 0.6236 GB, free: 7.809 MB / 0.5417 GB Notification: Performance of NFInst.instExpressions: time 0.003183/0.007412, allocations: 2.15 MB / 0.6257 GB, free: 5.648 MB / 0.5417 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.0006054/0.008017, allocations: 35.75 kB / 0.6257 GB, free: 5.613 MB / 0.5417 GB Notification: Performance of NFTyping.typeComponents: time 0.0003463/0.008363, allocations: 134.5 kB / 0.6259 GB, free: 5.48 MB / 0.5417 GB Notification: Performance of NFTyping.typeBindings: time 0.0003355/0.008699, allocations: 118.8 kB / 0.626 GB, free: 5.363 MB / 0.5417 GB Notification: Performance of NFTyping.typeClassSections: time 0.00106/0.009758, allocations: 0.5262 MB / 0.6265 GB, free: 4.836 MB / 0.5417 GB Notification: Performance of NFFlatten.flatten: time 0.000931/0.01069, allocations: 1.22 MB / 0.6277 GB, free: 3.609 MB / 0.5417 GB Notification: Performance of NFFlatten.resolveConnections: time 0.0004709/0.01116, allocations: 349.6 kB / 0.628 GB, free: 3.25 MB / 0.5417 GB Notification: Performance of NFEvalConstants.evaluate: time 0.0006862/0.01185, allocations: 0.612 MB / 0.6286 GB, free: 2.637 MB / 0.5417 GB Notification: Performance of NFSimplifyModel.simplify: time 0.0003018/0.01215, allocations: 310.9 kB / 0.6289 GB, free: 2.332 MB / 0.5417 GB Notification: Performance of NFPackage.collectConstants: time 0.0001182/0.01227, allocations: 124 kB / 0.629 GB, free: 2.211 MB / 0.5417 GB Notification: Performance of NFFlatten.collectFunctions: time 0.0002502/0.01252, allocations: 223.8 kB / 0.6292 GB, free: 1.992 MB / 0.5417 GB Notification: Performance of combineBinaries: time 0.0007196/0.01324, allocations: 1.517 MB / 0.6307 GB, free: 472 kB / 0.5417 GB Notification: Performance of replaceArrayConstructors: time 0.0006748/0.01391, allocations: 0.9099 MB / 0.6316 GB, free: 15.54 MB / 0.5573 GB Notification: Performance of NFVerifyModel.verify: time 0.0001461/0.01406, allocations: 56 kB / 0.6317 GB, free: 15.48 MB / 0.5573 GB Notification: Performance of FrontEnd: time 0.0001688/0.01423, allocations: 67.41 kB / 0.6317 GB, free: 15.41 MB / 0.5573 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 196 (191) * Number of variables: 196 (194) Notification: Performance of [SIM] Bindings: time 0.002789/0.01701, allocations: 3.98 MB / 0.6356 GB, free: 11.25 MB / 0.5573 GB Notification: Performance of [SIM] FunctionAlias: time 0.0006897/0.0177, allocations: 0.6357 MB / 0.6362 GB, free: 10.61 MB / 0.5573 GB Notification: Performance of [SIM] Early Inline: time 0.0022/0.0199, allocations: 3.124 MB / 0.6393 GB, free: 7.441 MB / 0.5573 GB Notification: Performance of [SIM] Simplify 1: time 0.0003333/0.02024, allocations: 301.2 kB / 0.6396 GB, free: 7.117 MB / 0.5573 GB Notification: Performance of [SIM] Alias: time 0.003854/0.02409, allocations: 5.006 MB / 0.6445 GB, free: 1.531 MB / 0.5573 GB Notification: Performance of [SIM] Simplify 2: time 0.0004321/0.02452, allocations: 212 kB / 0.6447 GB, free: 1.297 MB / 0.5573 GB Notification: Performance of [SIM] Remove Stream: time 0.0001417/0.02467, allocations: 255.9 kB / 0.6449 GB, free: 1.023 MB / 0.5573 GB Notification: Performance of [SIM] Detect States: time 0.000628/0.02529, allocations: 0.8917 MB / 0.6458 GB, free: 64 kB / 0.5573 GB Notification: Performance of [SIM] Events: time 0.2217/0.247, allocations: 275.2 kB / 0.646 GB, free: 30.86 MB / 0.5573 GB Notification: Performance of [SIM] Partitioning: time 0.000953/0.248, allocations: 0.9157 MB / 0.6469 GB, free: 30.75 MB / 0.5573 GB Notification: Performance of [SIM] Causalize: time 0.001618/0.2496, allocations: 1.573 MB / 0.6485 GB, free: 30.61 MB / 0.5573 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.001175/0.2508, allocations: 1.864 MB / 0.6503 GB, free: 30.61 MB / 0.5573 GB Error: Internal error NFAlgorithm.getInputsOutputs failed. Error: Internal error NBInitialization.main failed to apply modules! " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 2.5493233716115355] Failed to read output from testmodel.py, exit status != 0: 0.2561428062617779 0.262825184 0.24679024800000002 Calling exit ...