Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Airflow.Multizone.Examples.PowerLaw.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.001577/0.001577, allocations: 104.3 kB / 19.77 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.001738/0.001738, allocations: 219.5 kB / 23.07 MB, free: 4.844 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.42/1.42, allocations: 230.7 MB / 256.9 MB, free: 7.711 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 3.082/3.082, allocations: 0.5108 GB / 0.8167 GB, free: 17.74 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 13.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/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.Airflow.Multizone.Examples.PowerLaw,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|pow_2dat.V_flow|pow_1dat.V_flow|pow_V_flow.V_flow|pow_m_flow.V_flow",fileNamePrefix="Buildings_latest_Buildings.Airflow.Multizone.Examples.PowerLaw")
translateModel(Buildings.Airflow.Multizone.Examples.PowerLaw,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|pow_2dat.V_flow|pow_1dat.V_flow|pow_V_flow.V_flow|pow_m_flow.V_flow",fileNamePrefix="Buildings_latest_Buildings.Airflow.Multizone.Examples.PowerLaw") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.725e-05/1.725e-05, allocations: 2.281 kB / 1.187 GB, free: 13.45 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Airflow.Multizone.Examples.PowerLaw): time 0.2235/0.2235, allocations: 170.5 MB / 1.354 GB, free: 8.578 MB / 1.045 GB
Notification: Performance of NFInst.instExpressions: time 0.006978/0.2305, allocations: 3.944 MB / 1.358 GB, free: 4.625 MB / 1.045 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0006804/0.2312, allocations: 23.81 kB / 1.358 GB, free: 4.602 MB / 1.045 GB
Notification: Performance of NFTyping.typeComponents: time 0.001276/0.2324, allocations: 465 kB / 1.358 GB, free: 4.145 MB / 1.045 GB
Notification: Performance of NFTyping.typeBindings: time 0.004022/0.2365, allocations: 1.635 MB / 1.36 GB, free: 2.504 MB / 1.045 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003667/0.2401, allocations: 1.399 MB / 1.361 GB, free: 1.105 MB / 1.045 GB
Notification: Performance of NFFlatten.flatten: time 0.003105/0.2432, allocations: 2.119 MB / 1.363 GB, free: 14.98 MB / 1.061 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001386/0.2446, allocations: 0.9335 MB / 1.364 GB, free: 14.03 MB / 1.061 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002488/0.2471, allocations: 1.285 MB / 1.365 GB, free: 12.74 MB / 1.061 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001258/0.2484, allocations: 0.876 MB / 1.366 GB, free: 11.86 MB / 1.061 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001775/0.2485, allocations: 104 kB / 1.366 GB, free: 11.76 MB / 1.061 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002323/0.2509, allocations: 1.056 MB / 1.367 GB, free: 10.7 MB / 1.061 GB
Notification: Performance of combineBinaries: time 0.002314/0.2532, allocations: 2.33 MB / 1.369 GB, free: 8.355 MB / 1.061 GB
Notification: Performance of replaceArrayConstructors: time 0.001044/0.2542, allocations: 1.228 MB / 1.371 GB, free: 7.113 MB / 1.061 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001966/0.2544, allocations: 84 kB / 1.371 GB, free: 7.031 MB / 1.061 GB
Notification: Performance of FrontEnd: time 0.0001426/0.2546, allocations: 23.98 kB / 1.371 GB, free: 7.008 MB / 1.061 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 127 (113)
 * Number of variables: 127 (121)
Notification: Performance of [SIM] Bindings: time 0.005269/0.2598, allocations: 5.103 MB / 1.376 GB, free: 1.73 MB / 1.061 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0009572/0.2608, allocations: 0.9126 MB / 1.377 GB, free: 0.7969 MB / 1.061 GB
Notification: Performance of [SIM] Early Inline: time 0.00546/0.2662, allocations: 4.573 MB / 1.381 GB, free: 12.19 MB / 1.076 GB
Notification: Performance of [SIM] Simplify 1: time 0.00152/0.2678, allocations: 0.8488 MB / 1.382 GB, free: 11.29 MB / 1.076 GB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.00555/0.2733, allocations: 3.656 MB / 1.385 GB, free: 7.328 MB / 1.076 GB
Notification: Performance of [SIM] Simplify 2: time 0.001211/0.2745, allocations: 0.8195 MB / 1.386 GB, free: 6.461 MB / 1.076 GB
Notification: Performance of [SIM] Remove Stream: time 0.001034/0.2756, allocations: 0.8405 MB / 1.387 GB, free: 5.602 MB / 1.076 GB
Notification: Performance of [SIM] Detect States: time 0.000959/0.2765, allocations: 0.8089 MB / 1.388 GB, free: 4.727 MB / 1.076 GB
Notification: Performance of [SIM] Events: time 0.0005569/0.2771, allocations: 373.8 kB / 1.388 GB, free: 4.363 MB / 1.076 GB
Notification: Performance of [SIM] Partitioning: time 0.001592/0.2787, allocations: 1.456 MB / 1.39 GB, free: 2.859 MB / 1.076 GB
Notification: Performance of [SIM] Causalize: time 0.003667/0.2823, allocations: 2.51 MB / 1.392 GB, free: 288 kB / 1.076 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002912/0.2852, allocations: 2.911 MB / 1.395 GB, free: 13.37 MB / 1.092 GB
Notification: Performance of [INI] Simplify: time 0.003658/0.2889, allocations: 1.986 MB / 1.397 GB, free: 11.27 MB / 1.092 GB
Notification: Performance of [INI] Inline: time 0.005523/0.2944, allocations: 5.249 MB / 1.402 GB, free: 6 MB / 1.092 GB
Notification: Performance of [INI] Partitioning: time 0.0001514/0.2946, allocations: 60 kB / 1.402 GB, free: 5.93 MB / 1.092 GB
Notification: Performance of [INI] Cleanup: time 0.001048/0.2956, allocations: 0.7607 MB / 1.403 GB, free: 5.168 MB / 1.092 GB
Notification: Performance of [INI] Causalize: time 0.005203/0.3008, allocations: 3.451 MB / 1.406 GB, free: 1.664 MB / 1.092 GB
Notification: Performance of [INI] Tearing: time 0.0008592/0.3017, allocations: 0.6463 MB / 1.407 GB, free: 1.035 MB / 1.092 GB
Notification: Performance of [SIM] Initialization: time 1.383e-06/0.3017, allocations: 0 / 1.407 GB, free: 1.035 MB / 1.092 GB
Notification: Performance of [SIM] DAE-Mode: time 0.002317/0.304, allocations: 1.589 MB / 1.408 GB, free: 15.44 MB / 1.107 GB
Notification: Performance of [SIM] Remove Dummies: time 1.593e-05/0.304, allocations: 12.59 kB / 1.408 GB, free: 15.43 MB / 1.107 GB
Notification: Performance of [SIM] Tearing: time 0.0008434/0.3049, allocations: 0.6546 MB / 1.409 GB, free: 14.79 MB / 1.107 GB
Notification: Performance of [SIM] Categorize: time 3.061e-05/0.3049, allocations: 11.94 kB / 1.409 GB, free: 14.78 MB / 1.107 GB
Notification: Performance of [SIM] Solve: time 0.008296/0.3132, allocations: 6.147 MB / 1.415 GB, free: 8.66 MB / 1.107 GB
Notification: Performance of [SIM] Jacobian: time 0.008008/0.3212, allocations: 6.592 MB / 1.421 GB, free: 1.887 MB / 1.107 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 4
 * Number of ODE event partitions: ............... 1
 * 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: ............................. 4 (4) {pow_m_flow.mExc, pow_V_flow.mExc, pow_1dat.mExc, pow_2dat.mExc}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 22 (22) {$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, $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: ........... 64 (scalar:62, array:2, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:4)
 * 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: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 121 (scalar:115, array:6, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:4)
 * 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.993e-05/0.3213, allocations: 41.31 kB / 1.422 GB, free: 1.852 MB / 1.107 GB
Notification: Performance of SimCode: time 0.00902/0.3303, allocations: 5.413 MB / 1.427 GB, free: 12.31 MB / 1.123 GB
Notification: Performance of Templates: time 0.03826/0.3686, allocations: 23.53 MB / 1.45 GB, free: 4.809 MB / 1.139 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_latest_Buildings.Airflow.Multizone.Examples.PowerLaw.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Airflow.Multizone.Examples.PowerLaw.pipe ; mkfifo Buildings_latest_Buildings.Airflow.Multizone.Examples.PowerLaw.pipe ; head -c 1048576 < Buildings_latest_Buildings.Airflow.Multizone.Examples.PowerLaw.pipe >> ../files/Buildings_latest_Buildings.Airflow.Multizone.Examples.PowerLaw.sim & ./Buildings_latest_Buildings.Airflow.Multizone.Examples.PowerLaw  -abortSlowSimulation -alarm=800  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Airflow.Multizone.Examples.PowerLaw.pipe 2>&1) [Timeout 800]
[Calling os._exit(0), Time elapsed: 9.51501237199409]
Failed to read output from testmodel.py, exit status != 0:
0.37672388198552653 0.39102998499999997 0.13344361899999996
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f08089e6fb0>