Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized.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.001315/0.001315, allocations: 104.3 kB / 19.72 MB, free: 2.145 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.001545/0.001545, allocations: 209.2 kB / 23 MB, free: 4.965 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.287/1.287, allocations: 230.6 MB / 256.8 MB, free: 7.805 MB / 206.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.747/2.747, allocations: 0.49 GB / 0.7958 GB, free: 35.53 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/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(Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|Sloads|E.S.1.",fileNamePrefix="Buildings_12_Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized")
translateModel(Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|Sloads|E.S.1.",fileNamePrefix="Buildings_12_Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.139e-05/1.139e-05, allocations: 2.281 kB / 1.155 GB, free: 25.22 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized): time 0.0181/0.01811, allocations: 21.27 MB / 1.176 GB, free: 11.76 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.01979/0.0379, allocations: 16.84 MB / 1.192 GB, free: 0.8086 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002822/0.04072, allocations: 172.4 kB / 1.192 GB, free: 0.7227 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 0.00956/0.05028, allocations: 4.165 MB / 1.196 GB, free: 14.38 MB / 0.92 GB
Notification: Performance of NFTyping.typeBindings: time 0.01006/0.06034, allocations: 3.591 MB / 1.2 GB, free: 12.22 MB / 0.92 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003187/0.06353, allocations: 1.307 MB / 1.201 GB, free: 11.52 MB / 0.92 GB
Notification: Performance of NFFlatten.flatten: time 0.008208/0.07174, allocations: 6.765 MB / 1.208 GB, free: 8.371 MB / 0.92 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004375/0.07611, allocations: 2.461 MB / 1.21 GB, free: 6.922 MB / 0.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005731/0.08184, allocations: 3.296 MB / 1.213 GB, free: 5.656 MB / 0.92 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004189/0.08603, allocations: 2.154 MB / 1.216 GB, free: 4.652 MB / 0.92 GB
Notification: Performance of NFPackage.collectConstants: time 0.001042/0.08707, allocations: 325.1 kB / 1.216 GB, free: 4.652 MB / 0.92 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002855/0.08993, allocations: 0.8435 MB / 1.217 GB, free: 4.422 MB / 0.92 GB
Notification: Performance of combineBinaries: time 0.008797/0.09873, allocations: 7.51 MB / 1.224 GB, free: 15.66 MB / 0.9356 GB
Notification: Performance of replaceArrayConstructors: time 0.004024/0.1028, allocations: 4.54 MB / 1.228 GB, free: 12.58 MB / 0.9356 GB
Notification: Performance of NFVerifyModel.verify: time 0.00141/0.1042, allocations: 305.5 kB / 1.229 GB, free: 12.58 MB / 0.9356 GB
Notification: Performance of FrontEnd: time 0.0005782/0.1047, allocations: 96.39 kB / 1.229 GB, free: 12.55 MB / 0.9356 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 635 (516)
 * Number of variables: 635 (454)
Notification: Performance of [SIM] Bindings: time 0.0187/0.1234, allocations: 17.52 MB / 1.246 GB, free: 1.703 MB / 0.9356 GB
Notification: Performance of [SIM] FunctionAlias: time 0.002723/0.1262, allocations: 2.165 MB / 1.248 GB, free: 120 kB / 0.9356 GB
Notification: Performance of [SIM] Early Inline: time 0.01479/0.141, allocations: 13.99 MB / 1.262 GB, free: 3.285 MB / 0.9512 GB
Notification: Performance of [SIM] Simplify 1: time 0.004141/0.1451, allocations: 2.796 MB / 1.265 GB, free: 344 kB / 0.9512 GB
Notification: Performance of [SIM] Alias: time 0.01697/0.1621, allocations: 13.06 MB / 1.277 GB, free: 2.277 MB / 0.9669 GB
Notification: Performance of [SIM] Simplify 2: time 0.003047/0.1651, allocations: 2.417 MB / 1.28 GB, free: 15.76 MB / 0.9825 GB
Notification: Performance of [SIM] Remove Stream: time 0.001025/0.1661, allocations: 0.9054 MB / 1.28 GB, free: 14.8 MB / 0.9825 GB
Notification: Performance of [SIM] Detect States: time 0.002154/0.1683, allocations: 2.216 MB / 1.283 GB, free: 12.51 MB / 0.9825 GB
Notification: Performance of [SIM] Events: time 0.001781/0.1701, allocations: 1.457 MB / 1.284 GB, free: 11.01 MB / 0.9825 GB
Notification: Performance of [SIM] Partitioning: time 0.004252/0.1743, allocations: 4.011 MB / 1.288 GB, free: 6.949 MB / 0.9825 GB
Notification: Performance of [SIM] Causalize: time 0.01311/0.1874, allocations: 8.959 MB / 1.297 GB, free: 13.89 MB / 0.9981 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.009223/0.1967, allocations: 9.448 MB / 1.306 GB, free: 4.434 MB / 0.9981 GB
Notification: Performance of [INI] Simplify: time 0.009379/0.206, allocations: 6.451 MB / 1.312 GB, free: 13.65 MB / 1.014 GB
Notification: Performance of [INI] Inline: time 0.01648/0.2225, allocations: 16.23 MB / 1.328 GB, free: 13.38 MB / 1.029 GB
Notification: Performance of [INI] Partitioning: time 0.0006849/0.2232, allocations: 208.2 kB / 1.328 GB, free: 13.12 MB / 1.029 GB
Notification: Performance of [INI] Cleanup: time 0.003107/0.2263, allocations: 2.17 MB / 1.33 GB, free: 10.95 MB / 1.029 GB
Notification: Performance of [INI] Causalize: time 0.02056/0.2469, allocations: 13.61 MB / 1.344 GB, free: 13.07 MB / 1.045 GB
Notification: Performance of [INI] Tearing: time 0.003222/0.2501, allocations: 2.597 MB / 1.346 GB, free: 10.43 MB / 1.045 GB
Notification: Performance of [SIM] Initialization: time 1.653e-06/0.2501, allocations: 0 / 1.346 GB, free: 10.43 MB / 1.045 GB
Notification: Performance of [SIM] Remove Dummies: time 2.545e-05/0.2501, allocations: 2.281 kB / 1.346 GB, free: 10.43 MB / 1.045 GB
Notification: Performance of [SIM] Tearing: time 0.002731/0.2528, allocations: 2.09 MB / 1.348 GB, free: 8.32 MB / 1.045 GB
Notification: Performance of [SIM] Categorize: time 3.463e-05/0.2529, allocations: 19.92 kB / 1.348 GB, free: 8.301 MB / 1.045 GB
Notification: Performance of [SIM] Solve: time 0.01112/0.264, allocations: 8.252 MB / 1.356 GB, free: 8 kB / 1.045 GB
Notification: Performance of [SIM] Jacobian: time 0.007377/0.2714, allocations: 5.583 MB / 1.362 GB, free: 10.38 MB / 1.061 GB
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: ......... 1
 * 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: .................... 10 (10) {varLoad5.T_start, varLoad5.count, varLoad4.T_start, varLoad4.count, varLoad3.T_start, varLoad3.count, varLoad2.T_start, varLoad2.count, varLoad1.T_start, varLoad1.count}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 98 (98) {$SEV_97, $SEV_96, $SEV_95, $SEV_94, $SEV_93, $SEV_92, $SEV_91, $SEV_90, $SEV_89, $SEV_88, $SEV_87, $SEV_86, $SEV_85, $SEV_84, $SEV_83, $SEV_82, $SEV_81, $SEV_80, $SEV_79, $SEV_78, $SEV_77, $SEV_76, $SEV_75, $SEV_74, $SEV_73, $SEV_72, $SEV_71, $SEV_70, $SEV_69, $SEV_68, $SEV_67, $SEV_66, $SEV_65, $SEV_64, $SEV_63, $SEV_62, $SEV_61, $SEV_60, $SEV_59, $SEV_58, $SEV_57, $SEV_56, $SEV_55, $SEV_54, $SEV_53, $SEV_52, $SEV_51, $SEV_50, $SEV_49, $SEV_48, $SEV_47, $SEV_46, $SEV_45, $SEV_44, $SEV_43, $SEV_42, $SEV_41, $SEV_40, $SEV_39, $SEV_38, $SEV_37, $SEV_36, $SEV_35, $SEV_34, $SEV_33, $SEV_32, $SEV_31, $SEV_30, $SEV_29, $SEV_28, $SEV_27, $SEV_26, $SEV_25, $SEV_24, $SEV_23, $SEV_22, $SEV_21, $SEV_20, $SEV_19, $SEV_18, $SEV_17, $SEV_16, $SEV_15, $SEV_14, $SEV_13, $SEV_12, $SEV_11, $SEV_10, $SEV_9, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_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: ........... 276 (scalar:265, array:11, record:0)
 * Number of multi strong components: ............ 10 (algorithm:0, when:10, if:0, tuple:0)
 * Number of for-loop strong components: ......... 2 (resizable: 2, 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: ........... 557 (scalar:546, array:11, record:0)
 * Number of multi strong components: ............ 5 (algorithm:5, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 2 (resizable: 2, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: Performance of backend: time 0.0002343/0.2716, allocations: 174.2 kB / 1.362 GB, free: 10.22 MB / 1.061 GB
Notification: Performance of SimCode: time 0.02302/0.2946, allocations: 19.22 MB / 1.381 GB, free: 6.785 MB / 1.076 GB
Notification: Performance of Templates: time 0.0797/0.3743, allocations: 57.46 MB / 1.437 GB, free: 13.63 MB / 1.139 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_12_Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized.pipe ; mkfifo Buildings_12_Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized.pipe ; head -c 1048576 < Buildings_12_Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized.pipe >> ../files/Buildings_12_Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized.sim & ./Buildings_12_Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Electrical.DC.Lines.Examples.DCLinesLinearized.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 90.15290635079145]
Failed to read output from testmodel.py, exit status != 0:
0.3813685909844935 0.39411775400000004 0.286698985
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f7141192f20>