Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

No result after "Impact factor matrix ready" #40

Closed
intrepidvaillant opened this issue Aug 17, 2022 · 0 comments
Closed

No result after "Impact factor matrix ready" #40

intrepidvaillant opened this issue Aug 17, 2022 · 0 comments

Comments

@intrepidvaillant
Copy link

Hello,

I'm running an headless IPC server version of the 1.11 release. Everything work just fine except when I try to run a calculation. Everything seems to stop after the creation of the Impact factor matrix. I have try to let it run for 5 hours with no result.

Same setup and same Olca version but from GUI work just fine, I got a result in under 2 min. I don't know what I am doing wrong here.

Here is the log output from IPC calculation.

[NanoHttpd Request Processor (#1)] TRACE org.openlca.ipc.Server - handle request 1/get/model
[NanoHttpd Request Processor (#1)] TRACE org.openlca.ipc.Server - Call method get/model
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.Query - Get all class org.openlca.core.model.ImpactMethod with query select e from ImpactMethod e where e.refId = :refId
[NanoHttpd Request Processor (#1)] DEBUG org.openlca.core.database.Query - 1 results
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.EntityCache$Loader - register descriptor DAOs
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.EntityCache$Loader - register class class org.openlca.core.model.FlowProperty
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.FlowPropertyDao - get class org.openlca.core.model.FlowProperty for id=740
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.EntityCache$Loader - register class class org.openlca.core.model.Category
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.CategoryDao - get class org.openlca.core.model.Category for id=503
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.FlowPropertyDao - get class org.openlca.core.model.FlowProperty for id=736
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.FlowPropertyDao - get class org.openlca.core.model.FlowProperty for id=735
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.FlowPropertyDao - get class org.openlca.core.model.FlowProperty for id=734
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.FlowPropertyDao - get class org.openlca.core.model.FlowProperty for id=737
[NanoHttpd Request Processor (#1)] TRACE org.openlca.core.database.FlowPropertyDao - get class org.openlca.core.model.FlowProperty for id=738
[NanoHttpd Request Processor (#2)] TRACE org.openlca.ipc.Server - handle request 2/calculate
[NanoHttpd Request Processor (#2)] TRACE org.openlca.ipc.Server - Call method calculate
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.Query - Get all class org.openlca.core.model.ProductSystem with query select e from ProductSystem e where e.refId = :refId
[NanoHttpd Request Processor (#2)] DEBUG org.openlca.core.database.Query - 1 results
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - HikariPool-1 - configuration:
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - allowPoolSuspension.............false
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - autoCommit......................false
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - catalog.........................none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - connectionInitSql...............none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - connectionTestQuery.............none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - connectionTimeout...............30000
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - dataSource......................none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceClassName.............none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceJNDI..................none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceProperties............{password=<masked>}
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - driverClassName.................none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - healthCheckProperties...........{}
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - healthCheckRegistry.............none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - idleTimeout.....................600000
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - initializationFailTimeout.......1
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - isolateInternalQueries..........false
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - jdbcUrl.........................jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - leakDetectionThreshold..........0
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - maxLifetime.....................1800000
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - maximumPoolSize.................10
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - metricRegistry..................none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - metricsTrackerFactory...........none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - minimumIdle.....................10
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - password........................<masked>
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - poolName........................"HikariPool-1"
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - readOnly........................false
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - registerMbeans..................false
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - scheduledExecutor...............none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - schema..........................none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - threadFactory...................internal
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - transactionIsolation............default
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - username........................none
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.HikariConfig - validationTimeout...............5000
[NanoHttpd Request Processor (#2)] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.util.DriverDataSource - Loaded driver with class name org.apache.derby.jdbc.AutoloadedDriver for jdbcUrl=jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] INFO com.zaxxer.hikari.pool.PoolBase - HikariPool-1 - Driver does not support get/set network timeout for connections. (Feature not implemented: No details.)
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null) 
[NanoHttpd Request Processor (#2)] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] INFO org.openlca.ipc.handlers.Calculator - Calculate product system 05475ad7-3559-4fbe-a6e4-5cf436d33330
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.cache.FlowTable - initialize flow index
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[HikariPool-1 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Pool stats (total=1, active=1, idle=0, waiting=0)
[HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection org.apache.derby.impl.jdbc.EmbedConnection@1078207422 (XID = 12517738), (SESSIONID = 5), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null) 
[HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection org.apache.derby.impl.jdbc.EmbedConnection@24717701 (XID = 12517740), (SESSIONID = 7), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null) 
[HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection org.apache.derby.impl.jdbc.EmbedConnection@808595148 (XID = 12517742), (SESSIONID = 9), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null) 
[HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection org.apache.derby.impl.jdbc.EmbedConnection@1633081034 (XID = 12517744), (SESSIONID = 11), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null) 
[HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection org.apache.derby.impl.jdbc.EmbedConnection@1145670905 (XID = 12517746), (SESSIONID = 13), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null) 
[HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection org.apache.derby.impl.jdbc.EmbedConnection@1696090925 (XID = 12517748), (SESSIONID = 15), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null) 
[HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection org.apache.derby.impl.jdbc.EmbedConnection@1816469787 (XID = 12517750), (SESSIONID = 17), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null) 
[HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection org.apache.derby.impl.jdbc.EmbedConnection@1980381 (XID = 12517752), (SESSIONID = 19), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null) 
[HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection org.apache.derby.impl.jdbc.EmbedConnection@993182150 (XID = 12517754), (SESSIONID = 21), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null) 
[HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - After adding stats (total=10, active=1, idle=9, waiting=0)
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.cache.ProcessTable - build process index table
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.NativeSql - execute query select f_owner, f_flow, is_input from tbl_exchanges
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.cache.ProcessTable - 20801 providers mapped
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.math.SystemCalculator - calculate product system - full result
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.NativeSql - execute query select scope, f_owner, name, is_input_param, value, formula from tbl_parameters
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.cache.FlowTable - initialize flow index
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.NativeSql - execute query SELECT id, flow_type FROM tbl_flows
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.NativeSql - execute query SELECT id, f_owner, f_flow, f_flow_property_factor, f_unit, resulting_amount_value, resulting_amount_formula, is_input, avoided_product, f_default_provider, cost_value, cost_formula, f_currency, distribution_type, parameter1_value, parameter2_value, parameter3_value FROM tbl_exchanges
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.format.MatrixBuilder - Fill rate = 0.001018500155142017
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.format.MatrixBuilder - Finish matrix builder with sparse 10812*10812 matrix
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.format.MatrixBuilder - Fill rate = 0.005394028069981991
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.format.MatrixBuilder - Finish matrix builder with sparse 4147*10812 matrix
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.ImpactTable$ImpactTableBuilder - Build impact factor matrix for method 2157574
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.NativeSql - execute query SELECT id, ref_id, name, description, version, last_change, reference_unit FROM tbl_impact_categories where f_impact_method = 2157574
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.cache.ImpactFactorCache$FactorLoader - load impact factors for multiple categories
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.database.derby.DerbyDatabase - create connection: jdbc:derby:/olca-modules/olca-ipc/db
[NanoHttpd Request Processor (#2)] DEBUG com.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection org.apache.derby.impl.jdbc.EmbedConnection@417643963 (XID = 12517732), (SESSIONID = 3), (DATABASE = /olca-modules/olca-ipc/db), (DRDAID = null)  due to dirty commit state on close().
[NanoHttpd Request Processor (#2)] TRACE org.openlca.core.matrix.ImpactTable$ImpactTableBuilder - Impact factor matrix ready
[HikariPool-1 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Pool stats (total=10, active=0, idle=10, waiting=0)

I appreciate if you can take a look and maybe help me figuring out why it is not working
@intrepidvaillant intrepidvaillant closed this as not planned Won't fix, can't repro, duplicate, stale Sep 21, 2022
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
1 participant
@intrepidvaillant