Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AES_AES.Devel_test_models.Test_substation_001.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001622/0.001622, allocations: 107.4 kB / 18.19 MB, free: 4.117 MB / 14.72 MB
[Timeout remaining time 90]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001446/0.001446, allocations: 193.9 kB / 21.34 MB, free: 0.9766 MB / 14.72 MB
[Timeout remaining time 90]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.439/1.439, allocations: 225.6 MB / 249.9 MB, free: 3.223 MB / 190.1 MB
[Timeout remaining time 88]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AES main/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/AES main/package.mo): time 0.1002/0.1002, allocations: 22.68 MB / 327.7 MB, free: 7.301 MB / 254.1 MB
[Timeout remaining time 90]
Using package AES with version  (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AES main/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(AES.Devel_test_models.Test_substation_001,tolerance=1e-06,outputFormat="empty",numberOfIntervals=10000,variableFilter="",fileNamePrefix="AES_AES.Devel_test_models.Test_substation_001")
translateModel(AES.Devel_test_models.Test_substation_001,tolerance=1e-06,outputFormat="empty",numberOfIntervals=10000,variableFilter="",fileNamePrefix="AES_AES.Devel_test_models.Test_substation_001") [Timeout 660]
Notification: Performance of FrontEnd - loaded program: time 0.002065/0.002065, allocations: 70.89 kB / 461 MB, free: 41.04 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08823/0.09029, allocations: 58.02 MB / 0.5069 GB, free: 6.793 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(AES.Devel_test_models.Test_substation_001): time 0.01004/0.1003, allocations: 11.61 MB / 0.5182 GB, free: 11.13 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.006564/0.1069, allocations: 3.172 MB / 0.5213 GB, free: 7.949 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001751/0.1087, allocations: 63.62 kB / 0.5214 GB, free: 7.887 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001246/0.1099, allocations: 0.5385 MB / 0.5219 GB, free: 7.344 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.00334/0.1132, allocations: 1.363 MB / 0.5232 GB, free: 5.973 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002081/0.1153, allocations: 0.9207 MB / 0.5241 GB, free: 5.047 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007349/0.1227, allocations: 6.107 MB / 0.5301 GB, free: 14.92 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.005401/0.1281, allocations: 3.871 MB / 0.5339 GB, free: 11 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004238/0.1323, allocations: 2.478 MB / 0.5363 GB, free: 8.512 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004772/0.1371, allocations: 2.827 MB / 0.5391 GB, free: 5.676 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.00157/0.1386, allocations: 0.7305 MB / 0.5398 GB, free: 4.945 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001604/0.1403, allocations: 0.7305 MB / 0.5405 GB, free: 4.215 MB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001942/0.1422, allocations: 1.89 MB / 0.5423 GB, free: 2.32 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.004396/0.1466, allocations: 2.72 MB / 0.545 GB, free: 15.59 MB / 414.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.009428/0.156, allocations: 8.108 MB / 0.5529 GB, free: 7.457 MB / 414.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.3e-06/0.156, allocations: 0 / 0.5529 GB, free: 7.457 MB / 414.1 MB
Notification: Performance of FrontEnd: time 1.864e-06/0.156, allocations: 4 kB / 0.5529 GB, free: 7.453 MB / 414.1 MB
Notification: Performance of Transformations before backend: time 0.0001848/0.1562, allocations: 0 / 0.5529 GB, free: 7.453 MB / 414.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 844
 * Number of variables: 844
Notification: Performance of Generate backend data structure: time 0.01412/0.1703, allocations: 4.892 MB / 0.5577 GB, free: 2.488 MB / 414.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.797e-05/0.1704, allocations: 12.03 kB / 0.5577 GB, free: 2.477 MB / 414.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001245/0.1716, allocations: 438.3 kB / 0.5581 GB, free: 2.047 MB / 414.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004864/0.1765, allocations: 2.4 MB / 0.5605 GB, free: 15.59 MB / 430.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002981/0.1768, allocations: 276.9 kB / 0.5607 GB, free: 15.32 MB / 430.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001054/0.1778, allocations: 364.2 kB / 0.5611 GB, free: 14.96 MB / 430.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.009456/0.1873, allocations: 4.391 MB / 0.5654 GB, free: 10.54 MB / 430.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 6.193e-05/0.1874, allocations: 0 / 0.5654 GB, free: 10.54 MB / 430.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004065/0.1878, allocations: 136 kB / 0.5655 GB, free: 10.41 MB / 430.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.073e-05/0.1878, allocations: 80 kB / 0.5656 GB, free: 10.33 MB / 430.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.008126/0.196, allocations: 4.028 MB / 0.5695 GB, free: 6.297 MB / 430.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.03417/0.2301, allocations: 20.12 MB / 0.5892 GB, free: 0.9375 MB / 446.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01287/0.243, allocations: 5.472 MB / 0.5945 GB, free: 11.43 MB / 462.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003763/0.2468, allocations: 2.103 MB / 0.5965 GB, free: 9.316 MB / 462.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001947/0.247, allocations: 50.12 kB / 0.5966 GB, free: 9.27 MB / 462.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.902e-05/0.247, allocations: 56.75 kB / 0.5966 GB, free: 9.203 MB / 462.1 MB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001574/0.2486, allocations: 310.4 kB / 0.5969 GB, free: 8.898 MB / 462.1 MB
Notification: Performance of pre-optimization done (n=277): time 4.909e-06/0.2486, allocations: 0 / 0.5969 GB, free: 8.898 MB / 462.1 MB
Notification: Performance of matching and sorting (n=279): time 0.034/0.2826, allocations: 16.95 MB / 0.6135 GB, free: 6.758 MB / 478.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.94e-05/0.2827, allocations: 81.61 kB / 0.6136 GB, free: 6.664 MB / 478.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002701/0.2854, allocations: 1.706 MB / 0.6152 GB, free: 4.914 MB / 478.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0005415/0.2859, allocations: 69.7 kB / 0.6153 GB, free: 4.84 MB / 478.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001057/0.287, allocations: 1.323 MB / 0.6166 GB, free: 3.504 MB / 478.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001437/0.2884, allocations: 1.108 MB / 0.6177 GB, free: 2.387 MB / 478.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001082/0.2895, allocations: 0.5108 MB / 0.6182 GB, free: 1.867 MB / 478.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001239/0.2896, allocations: 305.1 kB / 0.6185 GB, free: 1.566 MB / 478.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.219/0.5086, allocations: 2.183 MB / 0.6206 GB, free: 101.5 MB / 478.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00373/0.5123, allocations: 2.309 MB / 0.6229 GB, free: 101.4 MB / 478.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04162/0.5539, allocations: 12.03 MB / 0.6346 GB, free: 98.28 MB / 478.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.005e-06/0.5539, allocations: 1.094 kB / 0.6346 GB, free: 98.28 MB / 478.1 MB
Notification: Performance of matching and sorting (n=393) (initialization): time 0.01196/0.5659, allocations: 6.522 MB / 0.641 GB, free: 95.38 MB / 478.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.532e-05/0.5659, allocations: 6.844 kB / 0.641 GB, free: 95.38 MB / 478.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.455e-05/0.5659, allocations: 0 / 0.641 GB, free: 95.38 MB / 478.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005105/0.571, allocations: 1.864 MB / 0.6428 GB, free: 94.21 MB / 478.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004115/0.5752, allocations: 0.7992 MB / 0.6436 GB, free: 94.02 MB / 478.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03636/0.6115, allocations: 76.38 MB / 0.7182 GB, free: 12 MB / 478.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002829/0.6143, allocations: 135.9 kB / 0.7183 GB, free: 11.87 MB / 478.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004991/0.6148, allocations: 108 kB / 0.7184 GB, free: 11.77 MB / 478.1 MB
Warning: Assuming fixed start value for the following 6 variables:
         HC.H.Ec:VARIABLE(flow=false fixed = true )  type: Real
         HC.H.Tfo:VARIABLE(min = 0.0 start = HC.H.Tstart unit = "K" fixed = true nominal = 300.0 )  "outlet fluid temp" type: Real
         HC.H.xpi:VARIABLE(start = 0.0 fixed = true protected = true )  type: Real
         ss1.HE.Tho:VARIABLE(min = 0.0 start = 371.95 unit = "K" fixed = true nominal = 300.0 )  type: Real
         ss1.HE.Tco:VARIABLE(min = 0.0 start = 323.15 unit = "K" fixed = true nominal = 300.0 )  type: Real
         clo.tubeC.fluidStream.w:VARIABLE(unit = "kg/s" fixed = true )  type: Real
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/Initialization.mo:1212:5-1212:82:writable] Error: Internal error Initialization.preBalanceInitialSystem2 failed because variable $DER.clo.tubeC.fluidStream.w:VARIABLE(unit = "kg/s" )  type: Real does not appear in any equation in the lambda 0 initial system and is not fixable.
Error: No system for the symbolic initialization was generated
[Timeout remaining time 659]