Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AixLib_AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor.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.00131/0.00131, allocations: 76.28 kB / 19.96 MB, free: 1.453 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.001435/0.001435, allocations: 172 kB / 23.23 MB, free: 4.207 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.334/1.334, allocations: 177.2 MB / 203.6 MB, free: 8.23 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo): time 0.05853/0.05853, allocations: 9.134 MB / 269.2 MB, free: 11.46 MB / 254.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo): time 0.0006883/0.0006883, allocations: 23.97 kB / 328.6 MB, free: 15.9 MB / 318.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo): time 2.058/2.058, allocations: 275.1 MB / 0.6477 GB, free: 436 kB / 0.4982 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 177]
Using package AixLib with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo)
Using package SDF with version 0.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo)
Using package Modelica_DeviceDrivers with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.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(AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="AixLib_AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor")
translateModel(AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="AixLib_AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.379e-05/2.379e-05, allocations: 4.109 kB / 0.9294 GB, free: 11.11 MB / 0.7794 GB
Notification: Performance of NFInst.instantiate(AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor): time 0.002109/0.002133, allocations: 0.9856 MB / 0.9304 GB, free: 10.12 MB / 0.7794 GB
Notification: Performance of NFInst.instExpressions: time 0.002066/0.004198, allocations: 1.501 MB / 0.9319 GB, free: 8.609 MB / 0.7794 GB
Notification: Performance of NFInst.updateImplicitVariability: time 7.857e-05/0.004277, allocations: 4 kB / 0.9319 GB, free: 8.605 MB / 0.7794 GB
Notification: Performance of NFTyping.typeComponents: time 0.0001217/0.004399, allocations: 23.67 kB / 0.9319 GB, free: 8.582 MB / 0.7794 GB
Notification: Performance of NFTyping.typeBindings: time 9.501e-05/0.004494, allocations: 51.58 kB / 0.932 GB, free: 8.531 MB / 0.7794 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001041/0.005535, allocations: 476.2 kB / 0.9324 GB, free: 8.082 MB / 0.7794 GB
Notification: Performance of NFFlatten.flatten: time 0.0006058/0.006141, allocations: 0.5503 MB / 0.9329 GB, free: 7.531 MB / 0.7794 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002263/0.006367, allocations: 92.08 kB / 0.933 GB, free: 7.441 MB / 0.7794 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003599/0.006727, allocations: 291.6 kB / 0.9333 GB, free: 7.156 MB / 0.7794 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0002566/0.006983, allocations: 151.6 kB / 0.9335 GB, free: 7.008 MB / 0.7794 GB
Notification: Performance of NFPackage.collectConstants: time 9.629e-05/0.00708, allocations: 52 kB / 0.9335 GB, free: 6.957 MB / 0.7794 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001265/0.007206, allocations: 55.98 kB / 0.9336 GB, free: 6.902 MB / 0.7794 GB
Notification: Performance of combineBinaries: time 0.000549/0.007755, allocations: 0.5353 MB / 0.9341 GB, free: 6.363 MB / 0.7794 GB
Notification: Performance of replaceArrayConstructors: time 0.0001636/0.007919, allocations: 225.1 kB / 0.9343 GB, free: 6.141 MB / 0.7794 GB
Notification: Performance of NFVerifyModel.verify: time 7.976e-05/0.007999, allocations: 36 kB / 0.9343 GB, free: 6.105 MB / 0.7794 GB
Notification: Performance of FrontEnd: time 2.891e-05/0.008027, allocations: 11.88 kB / 0.9343 GB, free: 6.094 MB / 0.7794 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 45 (45)
 * Number of variables: 45 (30)
Notification: Performance of [SIM] Bindings: time 0.001748/0.009776, allocations: 1.481 MB / 0.9358 GB, free: 4.484 MB / 0.7794 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0001776/0.009953, allocations: 145.2 kB / 0.9359 GB, free: 4.332 MB / 0.7794 GB
Notification: Performance of [SIM] Early Inline: time 0.001143/0.0111, allocations: 1.058 MB / 0.937 GB, free: 3.246 MB / 0.7794 GB
Notification: Performance of [SIM] Simplify 1: time 0.0004413/0.01154, allocations: 316 kB / 0.9373 GB, free: 2.91 MB / 0.7794 GB
Notification: Performance of [SIM] Alias: time 0.001476/0.01301, allocations: 1.009 MB / 0.9382 GB, free: 1.781 MB / 0.7794 GB
Notification: Performance of [SIM] Simplify 2: time 0.0003774/0.01339, allocations: 293.4 kB / 0.9385 GB, free: 1.469 MB / 0.7794 GB
Notification: Performance of [SIM] Remove Stream: time 0.0003714/0.01376, allocations: 309.3 kB / 0.9388 GB, free: 1.141 MB / 0.7794 GB
Notification: Performance of [SIM] Detect States: time 0.0007529/0.01451, allocations: 0.5423 MB / 0.9393 GB, free: 0.5312 MB / 0.7794 GB
Notification: Performance of [SIM] Events: time 0.0001633/0.01468, allocations: 94.3 kB / 0.9394 GB, free: 452 kB / 0.7794 GB
Notification: Performance of [SIM] Partitioning: time 0.0004024/0.01508, allocations: 313 kB / 0.9397 GB, free: 88 kB / 0.7794 GB
Notification: Performance of [SIM] Causalize: time 0.000842/0.01592, allocations: 0.574 MB / 0.9403 GB, free: 15.49 MB / 0.795 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0009757/0.0169, allocations: 0.9835 MB / 0.9413 GB, free: 14.51 MB / 0.795 GB
Notification: Performance of [INI] Simplify: time 0.001041/0.01794, allocations: 0.7224 MB / 0.942 GB, free: 13.73 MB / 0.795 GB
Notification: Performance of [INI] Inline: time 0.001321/0.01926, allocations: 1.253 MB / 0.9432 GB, free: 12.48 MB / 0.795 GB
Notification: Performance of [INI] Partitioning: time 5.851e-05/0.01932, allocations: 33.31 kB / 0.9432 GB, free: 12.43 MB / 0.795 GB
Notification: Performance of [INI] Cleanup: time 0.0004107/0.01973, allocations: 363.7 kB / 0.9436 GB, free: 12.08 MB / 0.795 GB
Notification: Performance of [INI] Causalize: time 0.0015/0.02123, allocations: 1.053 MB / 0.9446 GB, free: 11.02 MB / 0.795 GB
Notification: Performance of [INI] Tearing: time 3.395e-05/0.02126, allocations: 32 kB / 0.9446 GB, free: 10.99 MB / 0.795 GB
Notification: Performance of [SIM] Initialization: time 4.51e-07/0.02126, allocations: 0 / 0.9446 GB, free: 10.99 MB / 0.795 GB
Notification: Performance of [SIM] Remove Dummies: time 7.525e-06/0.02127, allocations: 4 kB / 0.9446 GB, free: 10.98 MB / 0.795 GB
Notification: Performance of [SIM] Tearing: time 1.128e-05/0.02128, allocations: 16 kB / 0.9446 GB, free: 10.97 MB / 0.795 GB
Notification: Performance of [SIM] Categorize: time 1.34e-05/0.0213, allocations: 7.984 kB / 0.9447 GB, free: 10.96 MB / 0.795 GB
Notification: Performance of [SIM] Solve: time 0.0003825/0.02168, allocations: 234.2 kB / 0.9449 GB, free: 10.73 MB / 0.795 GB
Notification: Performance of [SIM] Jacobian: time 1.177e-05/0.02169, allocations: 8 kB / 0.9449 GB, free: 10.73 MB / 0.795 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 3.7e-07/0.02169, allocations: 0 / 0.9449 GB, free: 10.73 MB / 0.795 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: ......... 3
 * 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: .................... 4 (4) {intPul1.booPul.y, intPul.booPul.y, booPul1.y, booPul.y}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 35 (20) {extIndBoo.u, extIndBoo.y, extIndBoo1.u, extIndBoo1.y, extIndBoo2.u, extIndBoo2.y, extIndBoo3.index, extIndBoo3.u, extIndBoo3.y, extIndBoo4.index, extIndBoo4.u, extIndBoo4.y, $TEV_7, $TEV_6, $TEV_5, $TEV_4, $TEV_3, $TEV_2, $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: ........... 35 (scalar:35, array:0, record:0)
 * Number of multi strong components: ............ 4 (algorithm:0, when:4, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 57 (scalar:57, array:0, record:0)
 * Number of multi strong components: ............ 4 (algorithm:4, 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: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 0.0001033/0.02179, allocations: 35.2 kB / 0.9449 GB, free: 10.7 MB / 0.795 GB
Notification: Performance of SimCode: time 0.001413/0.02321, allocations: 1.096 MB / 0.946 GB, free: 9.574 MB / 0.795 GB
Notification: Performance of Templates: time 0.008591/0.0318, allocations: 4.464 MB / 0.9503 GB, free: 5.223 MB / 0.795 GB
"
[Timeout remaining time 660]
make -j1 -f AixLib_AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor.makefile [Timeout 660]
(rm -f AixLib_AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor.pipe ; mkfifo AixLib_AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor.pipe ; head -c 1048576 < AixLib_AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor.pipe >> ../files/AixLib_AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor.sim & ./AixLib_AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor  -abortSlowSimulation -alarm=480 -lv LOG_STATS > AixLib_AixLib.Controls.OBC.CDL.Routing.Validation.BooleanExtractor.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 7.005834277719259]
Failed to read output from testmodel.py, exit status != 0:
0.03965267911553383 0.054300778 0.043257766
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fbbdc40d1b0>