Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PhotoVoltaics_PhotoVoltaics.Examples.SimpleCell.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.001528/0.001528, allocations: 104.3 kB / 19.76 MB, free: 1.906 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.001648/0.001648, allocations: 211.9 kB / 23.06 MB, free: 4.984 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.506/1.506, allocations: 230.6 MB / 256.9 MB, free: 7.777 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PhotoVoltaics 2.1.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PhotoVoltaics 2.1.0/package.mo): time 0.02993/0.02993, allocations: 5.486 MB / 318.8 MB, free: 13.5 MB / 254.1 MB
"
[Timeout remaining time 180]
Using package PhotoVoltaics with version 2.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PhotoVoltaics 2.1.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(PhotoVoltaics.Examples.SimpleCell,tolerance=1e-06,outputFormat="empty",numberOfIntervals=1000,variableFilter="",fileNamePrefix="PhotoVoltaics_PhotoVoltaics.Examples.SimpleCell")
translateModel(PhotoVoltaics.Examples.SimpleCell,tolerance=1e-06,outputFormat="empty",numberOfIntervals=1000,variableFilter="",fileNamePrefix="PhotoVoltaics_PhotoVoltaics.Examples.SimpleCell") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.353e-05/2.353e-05, allocations: 2.281 kB / 447.4 MB, free: 3.105 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(PhotoVoltaics.Examples.SimpleCell): time 0.00557/0.005594, allocations: 3.16 MB / 450.6 MB, free: 15.92 MB / 318.1 MB
Notification: Performance of NFInst.instExpressions: time 0.0036/0.009194, allocations: 1.203 MB / 451.8 MB, free: 14.71 MB / 318.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000453/0.009647, allocations: 11.94 kB / 451.8 MB, free: 14.7 MB / 318.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0009798/0.01063, allocations: 202.8 kB / 452 MB, free: 14.5 MB / 318.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0007772/0.0114, allocations: 158.9 kB / 452.1 MB, free: 14.35 MB / 318.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0004732/0.01188, allocations: 123.8 kB / 452.3 MB, free: 14.23 MB / 318.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0011/0.01298, allocations: 0.6267 MB / 452.9 MB, free: 13.6 MB / 318.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003088/0.01329, allocations: 72.28 kB / 453 MB, free: 13.53 MB / 318.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0004339/0.01372, allocations: 219.2 kB / 453.2 MB, free: 13.31 MB / 318.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0004121/0.01413, allocations: 223 kB / 453.4 MB, free: 13.09 MB / 318.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001091/0.01424, allocations: 52 kB / 453.4 MB, free: 13.04 MB / 318.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0005152/0.01476, allocations: 151.8 kB / 453.6 MB, free: 12.89 MB / 318.1 MB
Notification: Performance of combineBinaries: time 0.001139/0.01589, allocations: 0.9099 MB / 454.5 MB, free: 11.98 MB / 318.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0005621/0.01646, allocations: 0.5089 MB / 455 MB, free: 11.46 MB / 318.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001201/0.01658, allocations: 36 kB / 455 MB, free: 11.43 MB / 318.1 MB
Notification: Performance of FrontEnd: time 0.0001163/0.01669, allocations: 19.92 kB / 455.1 MB, free: 11.41 MB / 318.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 55 (55)
 * Number of variables: 55 (55)
Notification: Performance of [SIM] Bindings: time 0.003591/0.02028, allocations: 2.317 MB / 457.4 MB, free: 8.945 MB / 318.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0006027/0.02089, allocations: 319.4 kB / 457.7 MB, free: 8.621 MB / 318.1 MB
Notification: Performance of [SIM] Early Inline: time 0.002209/0.0231, allocations: 1.413 MB / 459.1 MB, free: 7.18 MB / 318.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0009411/0.02404, allocations: 417.4 kB / 459.5 MB, free: 6.727 MB / 318.1 MB
Notification: Performance of [SIM] Alias: time 0.003321/0.02736, allocations: 1.45 MB / 461 MB, free: 5.117 MB / 318.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0008247/0.02818, allocations: 411.9 kB / 461.4 MB, free: 4.672 MB / 318.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0001898/0.02837, allocations: 116.3 kB / 461.5 MB, free: 4.531 MB / 318.1 MB
Notification: Performance of [SIM] Detect States: time 0.0004337/0.02881, allocations: 304.6 kB / 461.8 MB, free: 4.18 MB / 318.1 MB
Notification: Performance of [SIM] Events: time 0.0003862/0.02919, allocations: 166.8 kB / 461.9 MB, free: 4.023 MB / 318.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0007512/0.02994, allocations: 451.5 kB / 462.4 MB, free: 3.566 MB / 318.1 MB
Notification: Performance of [SIM] Causalize: time 0.001354/0.0313, allocations: 0.5995 MB / 463 MB, free: 2.953 MB / 318.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.001389/0.03269, allocations: 0.96 MB / 463.9 MB, free: 1.992 MB / 318.1 MB
Notification: Performance of [INI] Simplify: time 0.002394/0.03508, allocations: 0.9758 MB / 464.9 MB, free: 0.9531 MB / 318.1 MB
Notification: Performance of [INI] Inline: time 0.002606/0.03769, allocations: 1.756 MB / 466.7 MB, free: 15.19 MB / 334.1 MB
Notification: Performance of [INI] Partitioning: time 0.0001147/0.0378, allocations: 36 kB / 466.7 MB, free: 15.14 MB / 334.1 MB
Notification: Performance of [INI] Cleanup: time 0.0004256/0.03823, allocations: 271.6 kB / 467 MB, free: 14.88 MB / 334.1 MB
Notification: Performance of [INI] Causalize: time 0.004233/0.04246, allocations: 1.777 MB / 468.8 MB, free: 13.09 MB / 334.1 MB
Notification: Performance of [INI] Tearing: time 0.001158/0.04362, allocations: 0.5523 MB / 469.3 MB, free: 12.55 MB / 334.1 MB
Notification: Performance of [SIM] Initialization: time 1.332e-06/0.04362, allocations: 4 kB / 469.3 MB, free: 12.55 MB / 334.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.001042/0.04466, allocations: 0.5107 MB / 469.8 MB, free: 12.04 MB / 334.1 MB
Notification: Performance of [SIM] Remove Dummies: time 1.161e-05/0.04467, allocations: 4 kB / 469.8 MB, free: 12.04 MB / 334.1 MB
Notification: Performance of [SIM] Tearing: time 0.0006357/0.04531, allocations: 444.5 kB / 470.3 MB, free: 11.61 MB / 334.1 MB
Notification: Performance of [SIM] Categorize: time 2.53e-05/0.04533, allocations: 7.938 kB / 470.3 MB, free: 11.61 MB / 334.1 MB
Notification: Performance of [SIM] Solve: time 0.002675/0.04801, allocations: 1.909 MB / 472.2 MB, free: 9.719 MB / 334.1 MB
Notification: Performance of [SIM] Jacobian: time 0.003911/0.05192, allocations: 3.219 MB / 475.4 MB, free: 6.457 MB / 334.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 2
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 0 (0) {}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 9 (9) {$SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_1, $TEV_0}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 25 (scalar:25, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 62 (scalar:62, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:1)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 2 (linear: 2, nonlinear:0)
Notification: Performance of backend: time 8.604e-05/0.05201, allocations: 35.59 kB / 475.4 MB, free: 6.426 MB / 334.1 MB
Notification: Performance of SimCode: time 0.003095/0.0551, allocations: 1.785 MB / 477.2 MB, free: 4.617 MB / 334.1 MB
Notification: Performance of Templates: time 0.01385/0.06895, allocations: 7.088 MB / 484.3 MB, free: 13.54 MB / 350.1 MB
"
[Timeout remaining time 660]
make -j1 -f PhotoVoltaics_PhotoVoltaics.Examples.SimpleCell.makefile [Timeout 660]
(rm -f PhotoVoltaics_PhotoVoltaics.Examples.SimpleCell.pipe ; mkfifo PhotoVoltaics_PhotoVoltaics.Examples.SimpleCell.pipe ; head -c 1048576 < PhotoVoltaics_PhotoVoltaics.Examples.SimpleCell.pipe >> ../files/PhotoVoltaics_PhotoVoltaics.Examples.SimpleCell.sim & ./PhotoVoltaics_PhotoVoltaics.Examples.SimpleCell  -jacobian=coloredNumerical -nls=newton -s=dassl -lv=LOG_STATS -abortSlowSimulation -alarm=480 -lv LOG_STATS > PhotoVoltaics_PhotoVoltaics.Examples.SimpleCell.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.577208318980411]
Failed to read output from testmodel.py, exit status != 0:
0.07915825501549989 0.094641154 0.073883078
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff2b0ae6fb0>