Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3.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.001329/0.001329, allocations: 104.5 kB / 18.05 MB, free: 4.32 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.001491/0.001491, allocations: 184.5 kB / 21.17 MB, free: 1.211 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.437/1.437, allocations: 225.6 MB / 249.7 MB, free: 3.246 MB / 190.1 MB
[Timeout remaining time 88]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo", uses=false) [Timeout 90]
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.841/0.841, allocations: 137.4 MB / 442.1 MB, free: 13.76 MB / 350.1 MB
[Timeout remaining time 89]
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/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(IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3")
translateModel(IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3") [Timeout 660]
Notification: Performance of FrontEnd - loaded program: time 0.002097/0.002097, allocations: 67.89 kB / 0.6133 GB, free: 1.613 MB / 0.4981 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4002/0.4023, allocations: 85.53 MB / 0.6969 GB, free: 14.84 MB / 0.5137 GB
Notification: Performance of NFInst.instantiate(IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3): time 0.008746/0.4111, allocations: 6.261 MB / 0.703 GB, free: 9.887 MB / 0.5137 GB
Notification: Performance of NFInst.instExpressions: time 0.1895/0.6006, allocations: 153.7 MB / 0.8531 GB, free: 448 kB / 0.6544 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001747/0.6023, allocations: 35.81 kB / 0.8531 GB, free: 412 kB / 0.6544 GB
Notification: Performance of NFTyping.typeComponents: time 0.001204/0.6035, allocations: 313 kB / 0.8534 GB, free: 96 kB / 0.6544 GB
Notification: Performance of NFTyping.typeBindings: time 0.00291/0.6064, allocations: 0.6629 MB / 0.8541 GB, free: 15.43 MB / 0.67 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00371/0.6102, allocations: 1.339 MB / 0.8554 GB, free: 14.1 MB / 0.67 GB
Notification: Performance of NFFlatten.flatten: time 0.003345/0.6135, allocations: 2.325 MB / 0.8576 GB, free: 11.77 MB / 0.67 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001601/0.6151, allocations: 0.7552 MB / 0.8584 GB, free: 10.98 MB / 0.67 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001317/0.6164, allocations: 0.7824 MB / 0.8591 GB, free: 10.2 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001433/0.6179, allocations: 0.7933 MB / 0.8599 GB, free: 9.398 MB / 0.67 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003767/0.6182, allocations: 188 kB / 0.8601 GB, free: 9.215 MB / 0.67 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001793/0.62, allocations: 0.9403 MB / 0.861 GB, free: 8.273 MB / 0.67 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005338/0.6206, allocations: 498.4 kB / 0.8615 GB, free: 7.785 MB / 0.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.0009356/0.6215, allocations: 0.8898 MB / 0.8624 GB, free: 6.891 MB / 0.67 GB
Notification: Performance of NFConvertDAE.convert: time 0.003257/0.6248, allocations: 2.732 MB / 0.865 GB, free: 4.148 MB / 0.67 GB
Notification: Performance of FrontEnd - DAE generated: time 4.508e-06/0.6248, allocations: 0 / 0.865 GB, free: 4.148 MB / 0.67 GB
Notification: Performance of FrontEnd: time 1.093e-06/0.6248, allocations: 4 kB / 0.865 GB, free: 4.145 MB / 0.67 GB
Notification: Performance of Transformations before backend: time 1.626e-05/0.6248, allocations: 0 / 0.865 GB, free: 4.145 MB / 0.67 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 341
 * Number of variables: 341
Notification: Performance of Generate backend data structure: time 0.003501/0.6283, allocations: 2.218 MB / 0.8672 GB, free: 1.867 MB / 0.67 GB
Notification: Performance of prepare preOptimizeDAE: time 4.016e-05/0.6283, allocations: 9.703 kB / 0.8672 GB, free: 1.859 MB / 0.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001874/0.6302, allocations: 371.4 kB / 0.8676 GB, free: 1.496 MB / 0.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001857/0.632, allocations: 1.244 MB / 0.8688 GB, free: 200 kB / 0.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.673e-05/0.6321, allocations: 106.7 kB / 0.8689 GB, free: 92 kB / 0.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.347/0.9791, allocations: 129.5 kB / 0.869 GB, free: 170.1 MB / 0.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003317/0.9824, allocations: 1.516 MB / 0.8705 GB, free: 169.5 MB / 0.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.121e-05/0.9825, allocations: 10.92 kB / 0.8705 GB, free: 169.5 MB / 0.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001396/0.9826, allocations: 59.39 kB / 0.8705 GB, free: 169.5 MB / 0.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.544e-05/0.9826, allocations: 32.47 kB / 0.8706 GB, free: 169.5 MB / 0.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003597/0.9862, allocations: 2.045 MB / 0.8726 GB, free: 169 MB / 0.67 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.007024/0.9933, allocations: 4.386 MB / 0.8769 GB, free: 166.8 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002645/0.9959, allocations: 1.347 MB / 0.8782 GB, free: 166.1 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001054/0.997, allocations: 0.4917 MB / 0.8787 GB, free: 165.8 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001312/0.9971, allocations: 58.91 kB / 0.8787 GB, free: 165.8 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001655/0.9988, allocations: 0.7922 MB / 0.8795 GB, free: 165.3 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=136): time 4.008e-06/0.9988, allocations: 1.359 kB / 0.8795 GB, free: 165.3 MB / 0.67 GB
Notification: Performance of matching and sorting (n=136): time 0.006042/1.005, allocations: 2.116 MB / 0.8816 GB, free: 164.2 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.731e-05/1.005, allocations: 353.7 kB / 0.8819 GB, free: 163.8 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00145/1.006, allocations: 1.08 MB / 0.8829 GB, free: 163.2 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001282/1.006, allocations: 53.55 kB / 0.883 GB, free: 163.1 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003976/1.007, allocations: 0.6189 MB / 0.8836 GB, free: 162.6 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002661/1.007, allocations: 473.3 kB / 0.8841 GB, free: 162.3 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000379/1.008, allocations: 288.6 kB / 0.8843 GB, free: 162.1 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 7.838e-05/1.008, allocations: 357.8 kB / 0.8847 GB, free: 161.8 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008969/1.008, allocations: 476.3 kB / 0.8851 GB, free: 161.5 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001102/1.01, allocations: 0.65 MB / 0.8858 GB, free: 161.1 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001964/1.012, allocations: 1.124 MB / 0.8869 GB, free: 160.5 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.41e-06/1.012, allocations: 0 / 0.8869 GB, free: 160.5 MB / 0.67 GB
Notification: Performance of matching and sorting (n=165) (initialization): time 0.003311/1.015, allocations: 1.518 MB / 0.8883 GB, free: 159.8 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 2.04e-05/1.015, allocations: 11.98 kB / 0.8884 GB, free: 159.7 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.112e-05/1.015, allocations: 6.016 kB / 0.8884 GB, free: 159.7 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001038/1.016, allocations: 165.8 kB / 0.8885 GB, free: 159.6 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001414/1.017, allocations: 294.6 kB / 0.8888 GB, free: 159.3 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003378/1.021, allocations: 3.294 MB / 0.892 GB, free: 155.7 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0013/1.022, allocations: 157.3 kB / 0.8922 GB, free: 155.6 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001032/1.022, allocations: 72.02 kB / 0.8922 GB, free: 155.5 MB / 0.67 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 11
 * Number of states: 0 ()
 * Number of discrete variables: 16 (weaDatInpCon.conTim.canRepeatWeatherFile,weaDatInpCon.conTimMin.canRepeatWeatherFile,weaDatInpCon.conTim.tNext,$PRE.weaDatInpCon.conTim.tNext,weaDatInpCon.conTimMin.tNext,$PRE.weaDatInpCon.conTimMin.tNext,$whenCondition1,$whenCondition2,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,$whenCondition3,$whenCondition4)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (161):
 * Single equations (assignments): 159
 * Array equations: 0
 * Algorithm blocks: 0
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,2), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.0007082/1.023, allocations: 387.7 kB / 0.8926 GB, free: 155.1 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002499/1.023, allocations: 151 kB / 0.8927 GB, free: 155 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003925/1.027, allocations: 1.98 MB / 0.8947 GB, free: 153 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.422e-05/1.027, allocations: 7.969 kB / 0.8947 GB, free: 153 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.779e-06/1.027, allocations: 0 / 0.8947 GB, free: 153 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005431/1.028, allocations: 434.1 kB / 0.8951 GB, free: 152.6 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001887/1.028, allocations: 35.94 kB / 0.8951 GB, free: 152.5 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008987/1.029, allocations: 113.2 kB / 0.8952 GB, free: 152.4 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001823/1.029, allocations: 113.8 kB / 0.8953 GB, free: 152.3 MB / 0.67 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002886/1.032, allocations: 1.714 MB / 0.897 GB, free: 150.6 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003169/1.035, allocations: 2.43 MB / 0.8994 GB, free: 148.2 MB / 0.67 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0008434/1.036, allocations: 0.5817 MB / 0.9 GB, free: 147.6 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.0008226/1.037, allocations: 0.7416 MB / 0.9007 GB, free: 146.8 MB / 0.67 GB
Notification: Performance of Backend: time 3.31e-07/1.037, allocations: 4 kB / 0.9007 GB, free: 146.8 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.004758/1.041, allocations: 1.764 MB / 0.9024 GB, free: 145.4 MB / 0.67 GB
Notification: Performance of SimCode: time 0.003624/1.045, allocations: 3.272 MB / 0.9056 GB, free: 142.1 MB / 0.67 GB
Notification: Performance of Templates: time 0.03594/1.081, allocations: 29.7 MB / 0.9346 GB, free: 112.7 MB / 0.67 GB
[Timeout remaining time 659]
make -j1 -f IDEAS_dev_IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3.makefile [Timeout 660]
(rm -f IDEAS_dev_IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3.pipe ; mkfifo IDEAS_dev_IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3.pipe >> ../files/IDEAS_dev_IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3.sim & ./IDEAS_dev_IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.BoundaryConditions.WeatherData.Examples.ReaderTMY3.pipe 2>&1) [Timeout 480]