Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.Examples.Tutorial.Example2.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.001392/0.001392, allocations: 77.31 kB / 19.76 MB, free: 2.051 MB / 14.72 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.0015/0.0015, allocations: 155.2 kB / 23 MB, free: 4.941 MB / 14.72 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.502/1.502, allocations: 177.2 MB / 203.4 MB, free: 9.297 MB / 190.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.8247/0.8247, allocations: 101.3 MB / 361.1 MB, free: 10.09 MB / 334.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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 3.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 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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.Examples.Tutorial.Example2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Examples.Tutorial.Example2")
translateModel(IDEAS.Examples.Tutorial.Example2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Examples.Tutorial.Example2") [Timeout 660]
"Notification: IDEAS requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002216/0.002216, allocations: 65.55 kB / 0.5356 GB, free: 5.559 MB / 446.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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 3.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.
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1902/0.1924, allocations: 85.87 MB / 0.6195 GB, free: 1.879 MB / 0.5137 GB
Notification: Performance of NFInst.instantiate(IDEAS.Examples.Tutorial.Example2): time 1.831/2.023, allocations: 482.1 MB / 1.09 GB, free: 1.609 MB / 0.8575 GB
Notification: Performance of NFInst.instExpressions: time 0.1284/2.152, allocations: 67.76 MB / 1.156 GB, free: 0.7773 MB / 0.8575 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02869/2.18, allocations: 0.5989 MB / 1.157 GB, free: 0.7773 MB / 0.8575 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/BoundaryConditions/Interfaces/PartialSimInfoManager.mo:151:3-154:55:writable] Warning: Connector weaBus is not balanced: The number of potential variables (20) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/InterzonalAirFlow/BaseClasses/PartialInterzonalAirFlowBoundary.mo:21:3-22:72:writable] Warning: Connector weaBus is not balanced: The number of potential variables (20) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialZone.mo:195:3-207:27:writable] Warning: Connector propsBusInt is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Zone.mo:6:3-18:28:writable] Warning: Connector propsBus is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:55:3-69:26:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:8:3-16:27:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:18:3-26:26:writable] Warning: Connector propsBus_b is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:145:3-157:26:writable] Warning: Connector propsBusInt is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:55:3-69:26:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:8:3-16:27:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:18:3-26:26:writable] Warning: Connector propsBus_b is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:145:3-157:26:writable] Warning: Connector propsBusInt is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:55:3-69:26:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:8:3-16:27:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:18:3-26:26:writable] Warning: Connector propsBus_b is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:145:3-157:26:writable] Warning: Connector propsBusInt is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:55:3-69:26:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:8:3-16:27:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:18:3-26:26:writable] Warning: Connector propsBus_b is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:145:3-157:26:writable] Warning: Connector propsBusInt is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:55:3-69:26:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:8:3-16:27:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:18:3-26:26:writable] Warning: Connector propsBus_b is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:145:3-157:26:writable] Warning: Connector propsBusInt is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:55:3-69:26:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:8:3-16:27:writable] Warning: Connector propsBus_a is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/ZoneBusVarMultiplicator.mo:18:3-26:26:writable] Warning: Connector propsBus_b is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/Interfaces/PartialSurface.mo:145:3-157:26:writable] Warning: Connector propsBusInt is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/Buildings/Components/InternalWall.mo:69:3-82:27:writable] Warning: Connector propsBus_b is not balanced: The number of potential variables (10) is not equal to the number of flow variables (0).
Notification: Performance of NFTyping.typeComponents: time 0.02006/2.2, allocations: 6.127 MB / 1.163 GB, free: 0.6133 MB / 0.8575 GB
Notification: Performance of NFTyping.typeBindings: time 0.03263/2.233, allocations: 7.505 MB / 1.17 GB, free: 388 kB / 0.8575 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02224/2.255, allocations: 6.283 MB / 1.176 GB, free: 14.96 MB / 0.8731 GB
Notification: Performance of NFFlatten.flatten: time 0.05131/2.307, allocations: 29.58 MB / 1.205 GB, free: 2.559 MB / 0.8731 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04643/2.353, allocations: 19.32 MB / 1.224 GB, free: 5.867 MB / 0.8887 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.05959/2.413, allocations: 19.67 MB / 1.243 GB, free: 3.457 MB / 0.9044 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03494/2.448, allocations: 12.08 MB / 1.255 GB, free: 7.77 MB / 0.92 GB
Notification: Performance of NFPackage.collectConstants: time 0.0118/2.459, allocations: 2.832 MB / 1.258 GB, free: 4.938 MB / 0.92 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02285/2.482, allocations: 5.231 MB / 1.263 GB, free: 96 kB / 0.92 GB
Notification: Performance of NFScalarize.scalarize: time 0.01421/2.496, allocations: 6.287 MB / 1.269 GB, free: 9.902 MB / 0.9356 GB
Notification: Performance of NFVerifyModel.verify: time 0.04096/2.537, allocations: 9.799 MB / 1.279 GB, free: 168 kB / 0.9356 GB
Notification: Performance of NFConvertDAE.convert: time 0.07658/2.614, allocations: 37.91 MB / 1.316 GB, free: 10.97 MB / 0.9825 GB
Notification: Performance of FrontEnd - DAE generated: time 9.127e-06/2.614, allocations: 0 / 1.316 GB, free: 10.97 MB / 0.9825 GB
Notification: Performance of FrontEnd: time 2.224e-06/2.614, allocations: 4 kB / 1.316 GB, free: 10.97 MB / 0.9825 GB
Notification: Performance of Transformations before backend: time 0.001607/2.616, allocations: 0 / 1.316 GB, free: 10.97 MB / 0.9825 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3970
 * Number of variables: 3970
Notification: Performance of Generate backend data structure: time 0.08598/2.702, allocations: 24.31 MB / 1.34 GB, free: 2.648 MB / 0.9981 GB
Notification: Performance of prepare preOptimizeDAE: time 5.96e-05/2.702, allocations: 8.031 kB / 1.34 GB, free: 2.641 MB / 0.9981 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.03166/2.733, allocations: 4.332 MB / 1.344 GB, free: 14.3 MB / 1.014 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.06437/2.798, allocations: 21.05 MB / 1.364 GB, free: 9.391 MB / 1.029 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002233/2.8, allocations: 1.474 MB / 1.366 GB, free: 7.855 MB / 1.029 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.007675/2.808, allocations: 1.535 MB / 1.367 GB, free: 6.32 MB / 1.029 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.07066/2.878, allocations: 19.23 MB / 1.386 GB, free: 2.602 MB / 1.045 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0008509/2.879, allocations: 17.75 kB / 1.386 GB, free: 2.586 MB / 1.045 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.006408/2.886, allocations: 0.6172 MB / 1.387 GB, free: 1.969 MB / 1.045 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0007054/2.886, allocations: 0.4955 MB / 1.387 GB, free: 1.473 MB / 1.045 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04848/2.935, allocations: 15.03 MB / 1.402 GB, free: 2.441 MB / 1.061 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 1.227/4.162, allocations: 52.52 MB / 1.453 GB, free: 0.4969 GB / 1.092 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02182/4.184, allocations: 7.919 MB / 1.461 GB, free: 0.496 GB / 1.092 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.009947/4.194, allocations: 4.093 MB / 1.465 GB, free: 0.4944 GB / 1.092 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001552/4.195, allocations: 269.8 kB / 1.465 GB, free: 0.4944 GB / 1.092 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01221/4.208, allocations: 4.95 MB / 1.47 GB, free: 0.492 GB / 1.092 GB
Notification: Performance of pre-optimization done (n=527): time 4.124e-05/4.208, allocations: 0 / 1.47 GB, free: 0.492 GB / 1.092 GB
Notification: Performance of matching and sorting (n=531): time 0.3066/4.514, allocations: 117.2 MB / 1.584 GB, free: 412.4 MB / 1.092 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003285/4.515, allocations: 1.115 MB / 1.586 GB, free: 411.1 MB / 1.092 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03527/4.55, allocations: 14.64 MB / 1.6 GB, free: 397.4 MB / 1.092 GB
Notification: Performance of collectPreVariables (initialization): time 0.002417/4.552, allocations: 141.7 kB / 1.6 GB, free: 397.2 MB / 1.092 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01296/4.565, allocations: 10.05 MB / 1.61 GB, free: 388.2 MB / 1.092 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003527/4.569, allocations: 1.976 MB / 1.612 GB, free: 386.5 MB / 1.092 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.009956/4.579, allocations: 1.988 MB / 1.614 GB, free: 384.5 MB / 1.092 GB
Notification: Performance of setup shared object (initialization): time 6.907e-05/4.579, allocations: 301.1 kB / 1.614 GB, free: 384.2 MB / 1.092 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01268/4.591, allocations: 5.391 MB / 1.619 GB, free: 378.8 MB / 1.092 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01577/4.607, allocations: 9.621 MB / 1.629 GB, free: 367.7 MB / 1.092 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02567/4.633, allocations: 12.33 MB / 1.641 GB, free: 354.4 MB / 1.092 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001365/4.633, allocations: 20 kB / 1.641 GB, free: 354.4 MB / 1.092 GB
Notification: Performance of matching and sorting (n=1168) (initialization): time 0.04792/4.681, allocations: 16.75 MB / 1.657 GB, free: 337.7 MB / 1.092 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001461/4.681, allocations: 36 kB / 1.657 GB, free: 337.6 MB / 1.092 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001877/4.681, allocations: 76.88 kB / 1.657 GB, free: 337.6 MB / 1.092 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008535/4.69, allocations: 2.407 MB / 1.659 GB, free: 335.2 MB / 1.092 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01095/4.701, allocations: 2.168 MB / 1.662 GB, free: 333.1 MB / 1.092 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02261/4.723, allocations: 26.16 MB / 1.687 GB, free: 305.7 MB / 1.092 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01572/4.739, allocations: 0.9209 MB / 1.688 GB, free: 304.8 MB / 1.092 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002961/4.742, allocations: 443.8 kB / 1.688 GB, free: 304.4 MB / 1.092 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02611/4.768, allocations: 10.71 MB / 1.699 GB, free: 293.7 MB / 1.092 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01606/4.784, allocations: 9.601 MB / 1.708 GB, free: 282.6 MB / 1.092 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02545/4.81, allocations: 12.31 MB / 1.72 GB, free: 269.3 MB / 1.092 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001549/4.81, allocations: 20.88 kB / 1.72 GB, free: 269.3 MB / 1.092 GB
Notification: Performance of matching and sorting (n=1168) (initialization_lambda0): time 0.04882/4.859, allocations: 16.74 MB / 1.737 GB, free: 252.4 MB / 1.092 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001478/4.859, allocations: 38.34 kB / 1.737 GB, free: 252.4 MB / 1.092 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001479/4.859, allocations: 76 kB / 1.737 GB, free: 252.3 MB / 1.092 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008397/4.867, allocations: 2.418 MB / 1.739 GB, free: 249.9 MB / 1.092 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01107/4.878, allocations: 2.16 MB / 1.741 GB, free: 247.7 MB / 1.092 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02232/4.901, allocations: 26.17 MB / 1.767 GB, free: 220.3 MB / 1.092 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01622/4.917, allocations: 1.016 MB / 1.768 GB, free: 219.3 MB / 1.092 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00301/4.92, allocations: 447.8 kB / 1.768 GB, free: 218.9 MB / 1.092 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 342
 * Number of states: 0 ()
 * Number of discrete variables: 41 (floor.q50_zone.using_custom_q50,window.q50_zone.using_custom_q50,outerWall3.q50_zone.using_custom_q50,outerWall2.q50_zone.using_custom_q50,outerWall1.q50_zone.using_custom_q50,outerWall.q50_zone.using_custom_q50,zone.setq50.use_custom_n50s[6],zone.setq50.use_custom_n50s[5],zone.setq50.use_custom_n50s[4],zone.setq50.use_custom_n50s[2],zone.setq50.use_custom_n50s[3],zone.setq50.use_custom_n50s[1],zone.setq50.use_custom_n50s[7],zone.setq50.allSurfacesCustom,zone.radDistrLw.computeCarroll,sim.weaDat.conTim.canRepeatWeatherFile,sim.weaDat.conTimMin.canRepeatWeatherFile,sim.radSol[1].solAzi.outsidePolarCircle,sim.radSol[2].solAzi.outsidePolarCircle,sim.radSol[3].solAzi.outsidePolarCircle,sim.radSol[4].solAzi.outsidePolarCircle,sim.radSol[5].solAzi.outsidePolarCircle,sim.radSol[6].solAzi.outsidePolarCircle,zone.setq50.use_custom_q50[7],zone.setq50.use_custom_q50[6],zone.setq50.use_custom_q50[5],zone.setq50.use_custom_q50[4],zone.setq50.use_custom_q50[2],zone.setq50.use_custom_q50[3],zone.setq50.use_custom_q50[1],window.setArea.use_custom_n50,outerWall3.setArea.use_custom_n50,outerWall2.setArea.use_custom_n50,outerWall1.setArea.use_custom_n50,outerWall.setArea.use_custom_n50,sim.weaDat.conTim.tNext,$PRE.sim.weaDat.conTim.tNext,sim.weaDat.conTimMin.tNext,$PRE.sim.weaDat.conTimMin.tNext,$whenCondition1,$whenCondition2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1088):
 * Single equations (assignments): 1073
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 13
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 12 systems
   {(1,7,100.0%), (5,27,100.0%), (1,2,100.0%), (1,1,100.0%), (1,2,100.0%), (1,1,100.0%), (1,2,100.0%), (1,1,100.0%), (1,2,100.0%), (1,1,100.0%), (1,1,100.0%), (2,14,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.005093/4.925, allocations: 0.751 MB / 1.769 GB, free: 218.2 MB / 1.092 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005081/4.93, allocations: 1.437 MB / 1.77 GB, free: 216.7 MB / 1.092 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03011/4.96, allocations: 10.11 MB / 1.78 GB, free: 206.5 MB / 1.092 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001157/4.96, allocations: 60 kB / 1.78 GB, free: 206.4 MB / 1.092 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0001147/4.96, allocations: 16 kB / 1.78 GB, free: 206.4 MB / 1.092 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02345/4.984, allocations: 7.333 MB / 1.787 GB, free: 198.9 MB / 1.092 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 postOpt removeSimpleEquations (simulation): time 0.06525/5.049, allocations: 25.31 MB / 1.812 GB, free: 173.4 MB / 1.092 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.436e-05/5.049, allocations: 16 kB / 1.812 GB, free: 173.4 MB / 1.092 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.006437/5.056, allocations: 1.133 MB / 1.813 GB, free: 172.3 MB / 1.092 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002651/5.058, allocations: 0.9162 MB / 1.814 GB, free: 171.3 MB / 1.092 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001626/5.06, allocations: 199.3 kB / 1.814 GB, free: 171.1 MB / 1.092 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01595/5.076, allocations: 22.48 MB / 1.836 GB, free: 147.3 MB / 1.092 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.623e-05/5.076, allocations: 19.94 kB / 1.836 GB, free: 147.3 MB / 1.092 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.03453/5.11, allocations: 14.8 MB / 1.851 GB, free: 131.9 MB / 1.092 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008625/5.119, allocations: 2.232 MB / 1.853 GB, free: 129.7 MB / 1.092 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005511/5.125, allocations: 170.4 kB / 1.853 GB, free: 129.6 MB / 1.092 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01023/5.135, allocations: 423.5 kB / 1.854 GB, free: 129.1 MB / 1.092 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002075/5.137, allocations: 434.8 kB / 1.854 GB, free: 128.7 MB / 1.092 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001551/5.138, allocations: 191.8 kB / 1.854 GB, free: 128.5 MB / 1.092 GB
Notification: Performance of sorting global known variables: time 0.02662/5.165, allocations: 9.857 MB / 1.864 GB, free: 118.7 MB / 1.092 GB
Notification: Performance of sort global known variables: time 3.1e-07/5.165, allocations: 0 / 1.864 GB, free: 118.7 MB / 1.092 GB
Notification: Performance of remove unused functions: time 0.03198/5.197, allocations: 5.637 MB / 1.869 GB, free: 113.1 MB / 1.092 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 63
 * Number of states: 28 (zone.airModel.vol.dynBal.U,zone.airModel.vol.dynBal.m,zone.airModel.vol.dynBal.mXi[1],outerWall.layMul.monLay[1].monLayDyn.T[1],outerWall.layMul.monLay[1].monLayDyn.T[2],outerWall.layMul.monLay[3].monLayDyn.T[1],outerWall.layMul.monLay[3].monLayDyn.T[2],outerWall.layMul.monLay[3].monLayDyn.T[3],outerWall1.layMul.monLay[1].monLayDyn.T[1],outerWall1.layMul.monLay[1].monLayDyn.T[2],outerWall1.layMul.monLay[3].monLayDyn.T[1],outerWall1.layMul.monLay[3].monLayDyn.T[2],outerWall1.layMul.monLay[3].monLayDyn.T[3],outerWall2.layMul.monLay[1].monLayDyn.T[1],outerWall2.layMul.monLay[1].monLayDyn.T[2],outerWall2.layMul.monLay[3].monLayDyn.T[1],outerWall2.layMul.monLay[3].monLayDyn.T[2],outerWall2.layMul.monLay[3].monLayDyn.T[3],outerWall3.layMul.monLay[1].monLayDyn.T[1],outerWall3.layMul.monLay[1].monLayDyn.T[2],outerWall3.layMul.monLay[3].monLayDyn.T[1],outerWall3.layMul.monLay[3].monLayDyn.T[2],outerWall3.layMul.monLay[3].monLayDyn.T[3],window.heaCapGlaInt.T,window.heaCapGlaExt.T,floor.layMul.monLay[1].monLayDyn.T[1],floor.layMul.monLay[1].monLayDyn.T[2],floor.layMul.monLay[2].monLayDyn.T[1])
 * Number of discrete variables: 4 ($whenCondition2,$whenCondition1,sim.weaDat.conTimMin.tNext,sim.weaDat.conTim.tNext)
 * Number of discrete states: 2 (sim.weaDat.conTimMin.tNext,sim.weaDat.conTim.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (531):
 * Single equations (assignments): 516
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 2
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 13
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 12 systems
   {(1,1,100.0%), (1,2,100.0%), (1,1,100.0%), (1,2,100.0%), (1,1,100.0%), (1,2,100.0%), (1,1,100.0%), (1,2,100.0%), (1,1,100.0%), (1,2,100.0%), (2,14,100.0%), (1,7,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.005091/5.202, allocations: 1.088 MB / 1.87 GB, free: 112.4 MB / 1.092 GB
Notification: Performance of simCode: created initialization part: time 0.04844/5.251, allocations: 21.25 MB / 1.891 GB, free: 90.83 MB / 1.092 GB
Notification: Performance of simCode: created event and clocks part: time 3.497e-05/5.251, allocations: 12 kB / 1.891 GB, free: 90.82 MB / 1.092 GB
Notification: Performance of simCode: created simulation system equations: time 0.01096/5.262, allocations: 5.57 MB / 1.897 GB, free: 85.09 MB / 1.092 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02556/5.287, allocations: 2.896 MB / 1.899 GB, free: 82.27 MB / 1.092 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0929/5.38, allocations: 37.1 MB / 1.936 GB, free: 45 MB / 1.092 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.03479/5.415, allocations: 10.67 MB / 1.946 GB, free: 34.28 MB / 1.092 GB
Notification: Performance of simCode: alias equations: time 0.02327/5.438, allocations: 4.655 MB / 1.951 GB, free: 29.61 MB / 1.092 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.008877/5.447, allocations: 0.9143 MB / 1.951 GB, free: 28.7 MB / 1.092 GB
Notification: Performance of SimCode: time 2.735e-06/5.447, allocations: 3.938 kB / 1.951 GB, free: 28.7 MB / 1.092 GB
Notification: Performance of Templates: time 1.254/6.701, allocations: 164.8 MB / 2.112 GB, free: 398.2 MB / 1.092 GB
"
[Timeout remaining time 653]
make -j1 -f IDEAS_IDEAS.Examples.Tutorial.Example2.makefile [Timeout 660]
(rm -f IDEAS_IDEAS.Examples.Tutorial.Example2.pipe ; mkfifo IDEAS_IDEAS.Examples.Tutorial.Example2.pipe ; head -c 1048576 < IDEAS_IDEAS.Examples.Tutorial.Example2.pipe >> ../files/IDEAS_IDEAS.Examples.Tutorial.Example2.sim & ./IDEAS_IDEAS.Examples.Tutorial.Example2  -abortSlowSimulation -alarm=480 -s gbode -gbnls=internal -gberr=embedded -gbm=radauIIA3 -lv LOG_STATS > IDEAS_IDEAS.Examples.Tutorial.Example2.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 18.162279655691236]
Failed to read output from testmodel.py, exit status != 0:
6.713594729080796 6.725903948 4.108728228
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f3da95c2fe0>