Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_symb_jac_PowerGrids.Electrical.Test.OneBusImpedanceOneLoad.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.001708/0.001708, allocations: 103.4 kB / 20.52 MB, free: 1.141 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.001935/0.001935, allocations: 212.5 kB / 23.82 MB, free: 4.332 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.589/1.589, allocations: 207.7 MB / 234.7 MB, free: 9.75 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo): time 0.0721/0.0721, allocations: 14.39 MB / 301.3 MB, free: 7.203 MB / 238.1 MB
"
[Timeout remaining time 180]
Using package PowerGrids with version 1.0.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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(PowerGrids.Electrical.Test.OneBusImpedanceOneLoad,tolerance=1e-06,outputFormat="mat",numberOfIntervals=50,variableFilter="infiniteBus.ERef|infiniteBus.PStart|infiniteBus.QStart|infiniteBus.R|infiniteBus.SNom|infiniteBus.UNom|infiniteBus.UPhaseStart|infiniteBus.URef|infiniteBus.UStart|infiniteBus.X|infiniteBus.Z.im|infiniteBus.Z.re|infiniteBus.i.im|infiniteBus.i.re|infiniteBus.localInit|infiniteBus.port.IBase|infiniteBus.port.IStart|infiniteBus.port.PStart|infiniteBus.port.QStart|infiniteBus.port.SBase|infiniteBus.port.SNom|infiniteBus.port.UBase|infiniteBus.port.UNom|infiniteBus.port.UPhaseStart|infiniteBus.port.UStart|infiniteBus.port.VBase|infiniteBus.port.VStart|infiniteBus.port.i.im|infiniteBus.port.i.re|infiniteBus.port.iStart.im|infiniteBus.port.iStart.re|infiniteBus.port.portVariablesPhases|infiniteBus.port.v.im|infiniteBus.port.v.re|infiniteBus.port.vStart.im|infiniteBus.port.vStart.re|infiniteBus.portVariablesPhases|infiniteBus.theta|infiniteBus.v.im|infiniteBus.v.re|loadPQ.PRef|loadPQ.PRefConst|loadPQ.PStart|loadPQ.QRef|loadPQ.QRefConst|loadPQ.QStart|loadPQ.SNom|loadPQ.UNom|loadPQ.UPhaseStart|loadPQ.URef|loadPQ.UStart|loadPQ.alpha|loadPQ.beta|loadPQ.localInit|loadPQ.port.IBase|loadPQ.port.IStart|loadPQ.port.PStart|loadPQ.port.QStart|loadPQ.port.SBase|loadPQ.port.SNom|loadPQ.port.UBase|loadPQ.port.UNom|loadPQ.port.UPhaseStart|loadPQ.port.UStart|loadPQ.port.VBase|loadPQ.port.VStart|loadPQ.port.i.im|loadPQ.port.i.re|loadPQ.port.iStart.im|loadPQ.port.iStart.re|loadPQ.port.portVariablesPhases|loadPQ.port.v.im|loadPQ.port.v.re|loadPQ.port.vStart.im|loadPQ.port.vStart.re|loadPQ.portVariablesPhases|systemPowerGrids.fNom|systemPowerGrids.initOpt|systemPowerGrids.omegaNom|systemPowerGrids.omegaRef|systemPowerGrids.referenceFrequency|time",fileNamePrefix="PowerGrids_symb_jac_PowerGrids.Electrical.Test.OneBusImpedanceOneLoad")
translateModel(PowerGrids.Electrical.Test.OneBusImpedanceOneLoad,tolerance=1e-06,outputFormat="mat",numberOfIntervals=50,variableFilter="infiniteBus.ERef|infiniteBus.PStart|infiniteBus.QStart|infiniteBus.R|infiniteBus.SNom|infiniteBus.UNom|infiniteBus.UPhaseStart|infiniteBus.URef|infiniteBus.UStart|infiniteBus.X|infiniteBus.Z.im|infiniteBus.Z.re|infiniteBus.i.im|infiniteBus.i.re|infiniteBus.localInit|infiniteBus.port.IBase|infiniteBus.port.IStart|infiniteBus.port.PStart|infiniteBus.port.QStart|infiniteBus.port.SBase|infiniteBus.port.SNom|infiniteBus.port.UBase|infiniteBus.port.UNom|infiniteBus.port.UPhaseStart|infiniteBus.port.UStart|infiniteBus.port.VBase|infiniteBus.port.VStart|infiniteBus.port.i.im|infiniteBus.port.i.re|infiniteBus.port.iStart.im|infiniteBus.port.iStart.re|infiniteBus.port.portVariablesPhases|infiniteBus.port.v.im|infiniteBus.port.v.re|infiniteBus.port.vStart.im|infiniteBus.port.vStart.re|infiniteBus.portVariablesPhases|infiniteBus.theta|infiniteBus.v.im|infiniteBus.v.re|loadPQ.PRef|loadPQ.PRefConst|loadPQ.PStart|loadPQ.QRef|loadPQ.QRefConst|loadPQ.QStart|loadPQ.SNom|loadPQ.UNom|loadPQ.UPhaseStart|loadPQ.URef|loadPQ.UStart|loadPQ.alpha|loadPQ.beta|loadPQ.localInit|loadPQ.port.IBase|loadPQ.port.IStart|loadPQ.port.PStart|loadPQ.port.QStart|loadPQ.port.SBase|loadPQ.port.SNom|loadPQ.port.UBase|loadPQ.port.UNom|loadPQ.port.UPhaseStart|loadPQ.port.UStart|loadPQ.port.VBase|loadPQ.port.VStart|loadPQ.port.i.im|loadPQ.port.i.re|loadPQ.port.iStart.im|loadPQ.port.iStart.re|loadPQ.port.portVariablesPhases|loadPQ.port.v.im|loadPQ.port.v.re|loadPQ.port.vStart.im|loadPQ.port.vStart.re|loadPQ.portVariablesPhases|systemPowerGrids.fNom|systemPowerGrids.initOpt|systemPowerGrids.omegaNom|systemPowerGrids.omegaRef|systemPowerGrids.referenceFrequency|time",fileNamePrefix="PowerGrids_symb_jac_PowerGrids.Electrical.Test.OneBusImpedanceOneLoad") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.79e-05/1.79e-05, allocations: 2.281 kB / 422.7 MB, free: 38.57 MB / 318.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Electrical.Test.OneBusImpedanceOneLoad): time 0.003533/0.003551, allocations: 3.801 MB / 426.5 MB, free: 34.75 MB / 318.1 MB
Notification: Performance of NFInst.instExpressions: time 0.002632/0.006183, allocations: 2.26 MB / 428.8 MB, free: 32.48 MB / 318.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001661/0.006349, allocations: 7.938 kB / 428.8 MB, free: 32.47 MB / 318.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0005291/0.006878, allocations: 230.7 kB / 429 MB, free: 32.24 MB / 318.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.001871/0.00875, allocations: 1.06 MB / 430.1 MB, free: 31.18 MB / 318.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0003922/0.009142, allocations: 247.1 kB / 430.3 MB, free: 30.94 MB / 318.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0007795/0.009921, allocations: 1.088 MB / 431.4 MB, free: 29.85 MB / 318.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001237/0.01005, allocations: 33.16 kB / 431.4 MB, free: 29.82 MB / 318.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0002959/0.01034, allocations: 358.6 kB / 431.8 MB, free: 29.47 MB / 318.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000288/0.01063, allocations: 326.6 kB / 432.1 MB, free: 29.15 MB / 318.1 MB
Notification: Performance of NFPackage.collectConstants: time 3.593e-05/0.01066, allocations: 24 kB / 432.1 MB, free: 29.12 MB / 318.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0004033/0.01107, allocations: 271.8 kB / 432.4 MB, free: 28.86 MB / 318.1 MB
Notification: Performance of combineBinaries: time 0.0006407/0.01171, allocations: 1.298 MB / 433.7 MB, free: 27.55 MB / 318.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0002549/0.01196, allocations: 0.7449 MB / 434.4 MB, free: 26.8 MB / 318.1 MB
Notification: Performance of NFVerifyModel.verify: time 5.825e-05/0.01202, allocations: 40 kB / 434.5 MB, free: 26.76 MB / 318.1 MB
Notification: Performance of FrontEnd: time 9.708e-05/0.01212, allocations: 39.95 kB / 434.5 MB, free: 26.72 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: 83 (62)
 * Number of variables: 83 (83)
Notification: Performance of [SIM] Bindings: time 0.001829/0.01395, allocations: 3.224 MB / 437.7 MB, free: 23.35 MB / 318.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0002058/0.01415, allocations: 259.4 kB / 438 MB, free: 23.09 MB / 318.1 MB
Notification: Performance of [SIM] Early Inline: time 0.00104/0.01519, allocations: 1.573 MB / 439.5 MB, free: 21.48 MB / 318.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0002098/0.0154, allocations: 192.3 kB / 439.7 MB, free: 21.25 MB / 318.1 MB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.001289/0.01669, allocations: 1.282 MB / 441 MB, free: 19.81 MB / 318.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0001799/0.01687, allocations: 180.3 kB / 441.2 MB, free: 19.58 MB / 318.1 MB
Notification: Performance of [SIM] Remove Stream: time 8.855e-05/0.01696, allocations: 132.2 kB / 441.3 MB, free: 19.42 MB / 318.1 MB
Notification: Performance of [SIM] Detect States: time 0.0002129/0.01717, allocations: 288.5 kB / 441.6 MB, free: 19.09 MB / 318.1 MB
Notification: Performance of [SIM] Events: time 3.825e-05/0.01721, allocations: 27.84 kB / 441.6 MB, free: 19.06 MB / 318.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0003789/0.01759, allocations: 449.9 kB / 442.1 MB, free: 18.61 MB / 318.1 MB
Notification: Performance of [SIM] Causalize: time 0.001158/0.01875, allocations: 1.181 MB / 443.3 MB, free: 17.41 MB / 318.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0004254/0.01917, allocations: 0.7729 MB / 444 MB, free: 16.63 MB / 318.1 MB
Notification: Performance of [INI] Simplify: time 0.0008996/0.02007, allocations: 0.6401 MB / 444.7 MB, free: 15.93 MB / 318.1 MB
Notification: Performance of [INI] Inline: time 0.001144/0.02122, allocations: 1.914 MB / 446.6 MB, free: 14.01 MB / 318.1 MB
Notification: Performance of [INI] Partitioning: time 5.046e-05/0.02127, allocations: 36 kB / 446.6 MB, free: 13.96 MB / 318.1 MB
Notification: Performance of [INI] Cleanup: time 0.0001194/0.02139, allocations: 235.8 kB / 446.8 MB, free: 13.73 MB / 318.1 MB
Notification: Performance of [INI] Causalize: time 0.001633/0.02302, allocations: 1.719 MB / 448.6 MB, free: 12 MB / 318.1 MB
Notification: Performance of [INI] Tearing: time 0.0001878/0.02321, allocations: 223.7 kB / 448.8 MB, free: 11.79 MB / 318.1 MB
Notification: Performance of [SIM] Initialization: time 6.01e-07/0.02321, allocations: 0 / 448.8 MB, free: 11.79 MB / 318.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.000366/0.02358, allocations: 382.9 kB / 449.2 MB, free: 11.41 MB / 318.1 MB
Notification: Performance of [SIM] Remove Dummies: time 7.674e-06/0.02358, allocations: 4.375 kB / 449.2 MB, free: 11.4 MB / 318.1 MB
Notification: Performance of [SIM] Tearing: time 0.0001681/0.02375, allocations: 249 kB / 449.4 MB, free: 11.16 MB / 318.1 MB
Notification: Performance of [SIM] Categorize: time 1.032e-05/0.02376, allocations: 8 kB / 449.4 MB, free: 11.15 MB / 318.1 MB
Notification: Performance of [SIM] Solve: time 0.001606/0.02537, allocations: 1.85 MB / 451.3 MB, free: 9.312 MB / 318.1 MB
Notification: Performance of [SIM] Jacobian: time 0.002806/0.02817, allocations: 3.648 MB / 454.9 MB, free: 5.574 MB / 318.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 1
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 0
 * 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: ................. 0 (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: ........... 44 (scalar:44, 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: ........... 68 (scalar:68, 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: Performance of backend: time 5.533e-05/0.02823, allocations: 43.61 kB / 455 MB, free: 5.535 MB / 318.1 MB
Warning: NSimJacobian.SimJacobian.create could not generate sparsity pattern.
Notification: Performance of SimCode: time 0.002522/0.03075, allocations: 2.528 MB / 457.5 MB, free: 2.973 MB / 318.1 MB
Notification: Performance of Templates: time 0.01408/0.04484, allocations: 8.535 MB / 466 MB, free: 10.46 MB / 334.1 MB
"
[Timeout remaining time 660]
make -j1 -f PowerGrids_symb_jac_PowerGrids.Electrical.Test.OneBusImpedanceOneLoad.makefile [Timeout 660]
(rm -f PowerGrids_symb_jac_PowerGrids.Electrical.Test.OneBusImpedanceOneLoad.pipe ; mkfifo PowerGrids_symb_jac_PowerGrids.Electrical.Test.OneBusImpedanceOneLoad.pipe ; head -c 1048576 < PowerGrids_symb_jac_PowerGrids.Electrical.Test.OneBusImpedanceOneLoad.pipe >> ../files/PowerGrids_symb_jac_PowerGrids.Electrical.Test.OneBusImpedanceOneLoad.sim & ./PowerGrids_symb_jac_PowerGrids.Electrical.Test.OneBusImpedanceOneLoad  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > PowerGrids_symb_jac_PowerGrids.Electrical.Test.OneBusImpedanceOneLoad.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.0370342140085995]
Failed to read output from testmodel.py, exit status != 0:
0.051905592961702496 0.066311931 0.051338602000000004
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f9ce426add0>