Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Chillers.Validation.CarnotVerifyEtaCarnot.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.0005863/0.0005863, allocations: 80.25 kB / 20.05 MB, free: 4.469 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.0006821/0.0006821, allocations: 177.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.8354/0.8354, allocations: 177.1 MB / 203.7 MB, free: 5.223 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.6711/0.6711, allocations: 154.5 MB / 414.7 MB, free: 0.7305 MB / 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.Chillers.Validation.CarnotVerifyEtaCarnot,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Chillers.Validation.CarnotVerifyEtaCarnot")
translateModel(IDEAS.Fluid.Chillers.Validation.CarnotVerifyEtaCarnot,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Chillers.Validation.CarnotVerifyEtaCarnot") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.465e-05/1.465e-05, allocations: 2.312 kB / 0.6195 GB, free: 13.05 MB / 0.5886 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Chillers.Validation.CarnotVerifyEtaCarnot): time 0.32/0.32, allocations: 120.8 MB / 0.7375 GB, free: 37.22 MB / 0.6355 GB
Notification: Performance of NFInst.instExpressions: time 0.02007/0.3401, allocations: 21.65 MB / 0.7586 GB, free: 22.33 MB / 0.6355 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001908/0.342, allocations: 172.6 kB / 0.7588 GB, free: 22.23 MB / 0.6355 GB
Notification: Performance of NFTyping.typeComponents: time 0.002187/0.3442, allocations: 1.511 MB / 0.7602 GB, free: 21.31 MB / 0.6355 GB
Notification: Performance of NFTyping.typeBindings: time 0.0059/0.3501, allocations: 4.468 MB / 0.7646 GB, free: 18.64 MB / 0.6355 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003382/0.3535, allocations: 2.349 MB / 0.7669 GB, free: 17.32 MB / 0.6355 GB
Notification: Performance of NFFlatten.flatten: time 0.007308/0.3608, allocations: 8.611 MB / 0.7753 GB, free: 13.11 MB / 0.6355 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002659/0.3634, allocations: 2.374 MB / 0.7776 GB, free: 11.54 MB / 0.6355 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005315/0.3687, allocations: 4.875 MB / 0.7824 GB, free: 9.199 MB / 0.6355 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001573/0.3703, allocations: 1.751 MB / 0.7841 GB, free: 8.562 MB / 0.6355 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002437/0.3706, allocations: 245.3 kB / 0.7843 GB, free: 8.562 MB / 0.6355 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002643/0.3732, allocations: 1.673 MB / 0.786 GB, free: 8.016 MB / 0.6355 GB
Notification: Performance of combineBinaries: time 0.002132/0.3753, allocations: 5.382 MB / 0.7912 GB, free: 4.699 MB / 0.6355 GB
Notification: Performance of replaceArrayConstructors: time 0.00112/0.3765, allocations: 3.378 MB / 0.7945 GB, free: 2.547 MB / 0.6355 GB
Notification: Performance of NFVerifyModel.verify: time 0.0003082/0.3768, allocations: 260.5 kB / 0.7948 GB, free: 2.547 MB / 0.6355 GB
Notification: Performance of FrontEnd: time 0.0002806/0.377, allocations: 100.4 kB / 0.7949 GB, free: 2.512 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: 388 (364)
 * Number of variables: 388 (379)
Notification: Performance of [SIM] Bindings: time 0.006571/0.3836, allocations: 12.88 MB / 0.8074 GB, free: 9.758 MB / 0.6511 GB
Notification: Performance of [SIM] FunctionAlias: time 0.001975/0.3856, allocations: 2.346 MB / 0.8097 GB, free: 7.504 MB / 0.6511 GB
Notification: Performance of [SIM] Early Inline: time 0.005872/0.3915, allocations: 8.816 MB / 0.8184 GB, free: 14.72 MB / 0.6667 GB
Notification: Performance of [SIM] Simplify 1: time 0.0006985/0.3922, allocations: 0.7453 MB / 0.8191 GB, free: 13.9 MB / 0.6667 GB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.008083/0.4002, allocations: 10.37 MB / 0.8292 GB, free: 2.617 MB / 0.6667 GB
Notification: Performance of [SIM] Simplify 2: time 0.0004804/0.4007, allocations: 0.5447 MB / 0.8297 GB, free: 2.027 MB / 0.6667 GB
Notification: Performance of [SIM] Remove Stream: time 0.000469/0.4012, allocations: 0.5409 MB / 0.8303 GB, free: 1.441 MB / 0.6667 GB
Notification: Performance of [SIM] Detect States: time 0.001063/0.4023, allocations: 1.678 MB / 0.8319 GB, free: 15.67 MB / 0.6823 GB
Notification: Performance of [SIM] Events: time 0.0001004/0.4024, allocations: 123.9 kB / 0.832 GB, free: 15.55 MB / 0.6823 GB
Notification: Performance of [SIM] Partitioning: time 0.001743/0.4041, allocations: 2.236 MB / 0.8342 GB, free: 13.18 MB / 0.6823 GB
Notification: Performance of [SIM] Causalize: time 0.003576/0.4077, allocations: 4.501 MB / 0.8386 GB, free: 8.586 MB / 0.6823 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002085/0.4098, allocations: 4.013 MB / 0.8425 GB, free: 4.57 MB / 0.6823 GB
Notification: Performance of [INI] Simplify: time 0.003281/0.413, allocations: 3.525 MB / 0.846 GB, free: 0.918 MB / 0.6823 GB
Notification: Performance of [INI] Inline: time 0.004616/0.4177, allocations: 8.471 MB / 0.8542 GB, free: 8.418 MB / 0.698 GB
Notification: Performance of [INI] Partitioning: time 0.0002205/0.4179, allocations: 151.9 kB / 0.8544 GB, free: 8.238 MB / 0.698 GB
Notification: Performance of [INI] Cleanup: time 0.0008/0.4187, allocations: 1.557 MB / 0.8559 GB, free: 6.68 MB / 0.698 GB
Notification: Performance of [INI] Causalize: time 0.007414/0.4261, allocations: 9.171 MB / 0.8649 GB, free: 13.32 MB / 0.7136 GB
Notification: Performance of [INI] Tearing: time 0.0004037/0.4265, allocations: 0.6409 MB / 0.8655 GB, free: 12.71 MB / 0.7136 GB
Notification: Performance of [SIM] Initialization: time 7.12e-07/0.4265, allocations: 0 / 0.8655 GB, free: 12.71 MB / 0.7136 GB
Notification: Performance of [SIM] DAE-Mode: time 0.0009466/0.4274, allocations: 1.232 MB / 0.8667 GB, free: 11.44 MB / 0.7136 GB
Notification: Performance of [SIM] Remove Dummies: time 9.819e-06/0.4275, allocations: 14 kB / 0.8667 GB, free: 11.42 MB / 0.7136 GB
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBackendDAE.mo:1531:9-1531:143:writable] Error: Internal error NBVariable.VariablePointers.getVarSafe failed for $FUN_55.p
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBackendDAE.mo:1531:9-1531:143:writable] Error: Internal error NBVariable.VariablePointers.getVarSafe failed for $FUN_45.p
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBackendDAE.mo:1531:9-1531:143:writable] Error: Internal error NBVariable.VariablePointers.getVarSafe failed for $FUN_43.p
Notification: Performance of [SIM] Tearing: time 0.0006288/0.4281, allocations: 1.033 MB / 0.8677 GB, free: 10.42 MB / 0.7136 GB
Notification: Performance of [SIM] Categorize: time 2.467e-05/0.4281, allocations: 23.92 kB / 0.8677 GB, free: 10.4 MB / 0.7136 GB
Notification: Performance of [SIM] Solve: time 0.004003/0.4321, allocations: 5.265 MB / 0.8729 GB, free: 5.137 MB / 0.7136 GB
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Util/NBDifferentiate.mo:823:30-824:7:writable] Error: Internal error NBVariable.getVarPointer failed for $FUN_55.p, because of wrong InstNode (not VAR_NODE). Show lowering errors with -d=failtrace.
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 2.8523464193567634]
Failed to read output from testmodel.py, exit status != 0:
0.4372315565124154 0.444533671 0.065805392
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7c5e4df11730>