2018-06-03 16:02:44,681 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.1.Final 2018-06-03 16:02:45,944 INFO [org.jboss.msc] (main) JBoss MSC version 1.2.6.Final 2018-06-03 16:02:46,072 INFO [org.jboss.as] (MSC service thread 1-7) WFLYSRV0049: WildFly Full 10.0.0.Final (WildFly Core 2.0.10.Final) starting 2018-06-03 16:02:46,073 DEBUG [org.jboss.as.config] (MSC service thread 1-7) Configured system properties: awt.toolkit = sun.awt.windows.WToolkit file.encoding = Cp1251 file.encoding.pkg = sun.io file.separator = \ java.awt.graphicsenv = sun.awt.Win32GraphicsEnvironment java.awt.printerjob = sun.awt.windows.WPrinterJob java.class.path = G:\Development\Servers\last-wildfly\jboss-modules.jar java.class.version = 52.0 java.endorsed.dirs = C:\Program Files\Java\jre1.8.0_144\lib\endorsed java.ext.dirs = C:\Program Files\Java\jre1.8.0_144\lib\ext;C:\WINDOWS\Sun\Java\lib\ext java.home = C:\Program Files\Java\jre1.8.0_144 java.io.tmpdir = C:\Users\MESSIE~1\AppData\Local\Temp\ java.library.path = C:\ProgramData\Oracle\Java\javapath;C:\WINDOWS\Sun\Java\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\ProgramData\Oracle\Java\javapath;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\Program Files (x86)\Skype\Phone\;G:\Soft\Git\cmd;C:\Program Files\MySQL\MySQL Utilities 1.6\;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\WINDOWS\System32\WindowsPowerShell\v1.0\;g:\games\iracing;g:\games\iracing;G:\Development\Servers\gradle-4.5.1\bin;C:\Program Files\dotnet\;C:\Program Files\CMake\bin;C:\Program Files\Microsoft SQL Server\130\Tools\Binn\;G:\Soft\nodejs\;C:\WINDOWS\System32\OpenSSH\;C:\Users\Messier82\AppData\Local\Microsoft\WindowsApps;C:\Program Files (x86)\Microsoft VS Code\bin;C:\Users\Messier82\AppData\Roaming\npm;;. java.net.preferIPv4Stack = true java.runtime.name = Java(TM) SE Runtime Environment java.runtime.version = 1.8.0_144-b01 java.specification.name = Java Platform API Specification java.specification.vendor = Oracle Corporation java.specification.version = 1.8 java.util.logging.manager = org.jboss.logmanager.LogManager java.vendor = Oracle Corporation java.vendor.url = http://java.oracle.com/ java.vendor.url.bug = http://bugreport.sun.com/bugreport/ java.version = 1.8.0_144 java.vm.info = mixed mode java.vm.name = Java HotSpot(TM) 64-Bit Server VM java.vm.specification.name = Java Virtual Machine Specification java.vm.specification.vendor = Oracle Corporation java.vm.specification.version = 1.8 java.vm.vendor = Oracle Corporation java.vm.version = 25.144-b01 javax.management.builder.initial = org.jboss.as.jmx.PluggableMBeanServerBuilder javax.xml.datatype.DatatypeFactory = __redirected.__DatatypeFactory javax.xml.parsers.DocumentBuilderFactory = __redirected.__DocumentBuilderFactory javax.xml.parsers.SAXParserFactory = __redirected.__SAXParserFactory javax.xml.stream.XMLEventFactory = __redirected.__XMLEventFactory javax.xml.stream.XMLInputFactory = __redirected.__XMLInputFactory javax.xml.stream.XMLOutputFactory = __redirected.__XMLOutputFactory javax.xml.transform.TransformerFactory = __redirected.__TransformerFactory javax.xml.validation.SchemaFactory:http://www.w3.org/2001/XMLSchema = __redirected.__SchemaFactory javax.xml.xpath.XPathFactory:http://java.sun.com/jaxp/xpath/dom = __redirected.__XPathFactory jboss.home.dir = G:\Development\Servers\last-wildfly jboss.host.name = desktop-ap5tg7f jboss.modules.dir = G:\Development\Servers\last-wildfly\modules jboss.modules.system.pkgs = org.jboss.byteman jboss.node.name = desktop-ap5tg7f jboss.qualified.host.name = desktop-ap5tg7f jboss.server.base.dir = G:\Development\Servers\last-wildfly\standalone jboss.server.config.dir = G:\Development\Servers\last-wildfly\standalone\configuration jboss.server.data.dir = G:\Development\Servers\last-wildfly\standalone\data jboss.server.deploy.dir = G:\Development\Servers\last-wildfly\standalone\data\content jboss.server.log.dir = G:\Development\Servers\last-wildfly\standalone\log jboss.server.name = desktop-ap5tg7f jboss.server.persist.config = true jboss.server.temp.dir = G:\Development\Servers\last-wildfly\standalone\tmp line.separator = logging.configuration = file:G:\Development\Servers\last-wildfly\standalone\configuration/logging.properties module.path = G:\Development\Servers\last-wildfly\modules org.jboss.boot.log.file = G:\Development\Servers\last-wildfly\standalone\log\server.log org.jboss.resolver.warning = true org.xml.sax.driver = __redirected.__XMLReaderFactory os.arch = amd64 os.name = Windows 10 os.version = 10.0 path.separator = ; program.name = standalone.bat sun.arch.data.model = 64 sun.boot.class.path = C:\Program Files\Java\jre1.8.0_144\lib\resources.jar;C:\Program Files\Java\jre1.8.0_144\lib\rt.jar;C:\Program Files\Java\jre1.8.0_144\lib\sunrsasign.jar;C:\Program Files\Java\jre1.8.0_144\lib\jsse.jar;C:\Program Files\Java\jre1.8.0_144\lib\jce.jar;C:\Program Files\Java\jre1.8.0_144\lib\charsets.jar;C:\Program Files\Java\jre1.8.0_144\lib\jfr.jar;C:\Program Files\Java\jre1.8.0_144\classes sun.boot.library.path = C:\Program Files\Java\jre1.8.0_144\bin sun.cpu.endian = little sun.cpu.isalist = amd64 sun.desktop = windows sun.io.unicode.encoding = UnicodeLittle sun.java.command = G:\Development\Servers\last-wildfly\jboss-modules.jar -mp G:\Development\Servers\last-wildfly\modules org.jboss.as.standalone -Djboss.home.dir=G:\Development\Servers\last-wildfly --server-config=standalone.pvstream-dev.xml sun.java.launcher = SUN_STANDARD sun.jnu.encoding = Cp1251 sun.management.compiler = HotSpot 64-Bit Tiered Compilers sun.os.patch.level = user.country = US user.dir = G:\Development\Servers\last-wildfly\bin user.home = C:\Users\Messier82 user.language = en user.name = Messier82 user.script = user.timezone = Europe/Helsinki user.variant = 2018-06-03 16:02:46,092 DEBUG [org.jboss.as.config] (MSC service thread 1-7) VM Arguments: -Dprogram.name=standalone.bat -Xms64M -Xmx1024M -XX:MetaspaceSize=96M -XX:MaxMetaspaceSize=256m -Djava.net.preferIPv4Stack=true -Djboss.modules.system.pkgs=org.jboss.byteman -agentlib:jdwp=transport=dt_socket,address=9990,server=y,suspend=n -Dorg.jboss.boot.log.file=G:\Development\Servers\last-wildfly\standalone\log\server.log -Dlogging.configuration=file:G:\Development\Servers\last-wildfly\standalone\configuration/logging.properties 2018-06-03 16:02:53,490 INFO [org.jboss.as.server] (Controller Boot Thread) WFLYSRV0039: Creating http management service using socket-binding (management-http) 2018-06-03 16:02:53,584 INFO [org.xnio] (MSC service thread 1-7) XNIO version 3.3.4.Final 2018-06-03 16:02:53,637 INFO [org.xnio.nio] (MSC service thread 1-7) XNIO NIO Implementation Version 3.3.4.Final 2018-06-03 16:02:53,852 WARN [org.jboss.as.txn] (ServerService Thread Pool -- 52) WFLYTX0013: Node identifier property is set to the default value. Please make sure it is unique. 2018-06-03 16:02:53,860 INFO [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 37) WFLYCLINF0001: Activating Infinispan subsystem. 2018-06-03 16:02:53,861 INFO [org.jboss.as.security] (ServerService Thread Pool -- 51) WFLYSEC0002: Activating Security Subsystem 2018-06-03 16:02:53,871 INFO [org.wildfly.extension.io] (ServerService Thread Pool -- 36) WFLYIO001: Worker 'default' has auto-configured to 32 core threads with 256 task threads based on your 16 available processors 2018-06-03 16:02:53,872 INFO [org.jboss.as.security] (MSC service thread 1-6) WFLYSEC0001: Current PicketBox version=4.9.4.Final 2018-06-03 16:02:53,886 INFO [org.jboss.as.naming] (ServerService Thread Pool -- 44) WFLYNAM0001: Activating Naming Subsystem 2018-06-03 16:02:53,911 INFO [org.jboss.remoting] (MSC service thread 1-1) JBoss Remoting version 4.0.18.Final 2018-06-03 16:02:53,926 INFO [org.jboss.as.naming] (MSC service thread 1-8) WFLYNAM0003: Starting Naming Service 2018-06-03 16:02:53,927 INFO [org.jboss.as.mail.extension] (MSC service thread 1-2) WFLYMAIL0001: Bound mail session [java:jboss/mail/Default] 2018-06-03 16:02:54,067 INFO [org.jboss.as.connector] (MSC service thread 1-1) WFLYJCA0009: Starting JCA Subsystem (WildFly/IronJacamar 1.3.2.Final) 2018-06-03 16:02:54,216 INFO [org.jboss.as.webservices] (ServerService Thread Pool -- 54) WFLYWS0002: Activating WebServices Extension 2018-06-03 16:02:54,502 WARN [org.jboss.as.mail.extension] (MSC service thread 1-5) WFLYMAIL0009: Host name [mx.int] could not be resolved! 2018-06-03 16:02:54,717 INFO [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 32) WFLYJCA0005: Deploying non-JDBC-compliant driver class com.mysql.jdbc.Driver (version 5.1) 2018-06-03 16:02:54,718 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-7) WFLYJCA0018: Started Driver service with driver-name = MySqlJDBCDriver 2018-06-03 16:02:54,830 INFO [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 32) WFLYJCA0004: Deploying JDBC-compliant driver class org.h2.Driver (version 1.3) 2018-06-03 16:02:54,831 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-6) WFLYJCA0018: Started Driver service with driver-name = h2 2018-06-03 16:02:54,924 INFO [org.wildfly.extension.undertow] (MSC service thread 1-1) WFLYUT0003: Undertow 1.3.15.Final starting 2018-06-03 16:02:54,923 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 53) WFLYUT0003: Undertow 1.3.15.Final starting 2018-06-03 16:02:55,031 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-2) WFLYJCA0001: Bound data source [java:jboss/datasources/ExampleDS] 2018-06-03 16:02:55,031 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-7) WFLYJCA0001: Bound data source [java:jboss/datasources/pvstream] 2018-06-03 16:02:55,031 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-4) WFLYJCA0001: Bound data source [java:jboss/datasources/hardware] 2018-06-03 16:02:55,102 INFO [org.jboss.as.ejb3] (MSC service thread 1-1) WFLYEJB0481: Strict pool slsb-strict-max-pool is using a max instance size of 256 (per class), which is derived from thread worker pool sizing. 2018-06-03 16:02:55,102 INFO [org.jboss.as.ejb3] (MSC service thread 1-2) WFLYEJB0482: Strict pool mdb-strict-max-pool is using a max instance size of 64 (per class), which is derived from the number of CPUs on this host. 2018-06-03 16:02:55,265 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 53) WFLYUT0014: Creating file handler for path 'G:\Development\Servers\last-wildfly/welcome-content' with options [directory-listing: 'false', follow-symlink: 'false', case-sensitive: 'true', safe-symlink-paths: '[]'] 2018-06-03 16:02:55,295 INFO [org.wildfly.extension.undertow] (MSC service thread 1-8) WFLYUT0012: Started server default-server. 2018-06-03 16:02:55,296 INFO [org.wildfly.extension.undertow] (MSC service thread 1-4) WFLYUT0018: Host default-host starting 2018-06-03 16:02:55,526 INFO [org.wildfly.extension.undertow] (MSC service thread 1-1) WFLYUT0006: Undertow HTTP listener default listening on 127.0.0.1:8180 2018-06-03 16:02:55,941 INFO [org.jboss.as.server.deployment.scanner] (MSC service thread 1-1) WFLYDS0013: Started FileSystemDeploymentService for directory G:\Development\Servers\last-wildfly\standalone\deployments 2018-06-03 16:02:55,947 INFO [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0027: Starting deployment of "ROOT.war" (runtime-name: "ROOT.war") 2018-06-03 16:02:56,542 INFO [org.infinispan.factories.GlobalComponentRegistry] (MSC service thread 1-7) ISPN000128: Infinispan version: Infinispan 'Mahou' 8.1.0.Final 2018-06-03 16:02:56,542 INFO [org.infinispan.factories.GlobalComponentRegistry] (MSC service thread 1-5) ISPN000128: Infinispan version: Infinispan 'Mahou' 8.1.0.Final 2018-06-03 16:02:56,542 INFO [org.infinispan.factories.GlobalComponentRegistry] (MSC service thread 1-8) ISPN000128: Infinispan version: Infinispan 'Mahou' 8.1.0.Final 2018-06-03 16:02:56,542 INFO [org.infinispan.factories.GlobalComponentRegistry] (MSC service thread 1-4) ISPN000128: Infinispan version: Infinispan 'Mahou' 8.1.0.Final 2018-06-03 16:02:57,471 INFO [org.jboss.ws.common.management] (MSC service thread 1-6) JBWS022052: Starting JBossWS 5.1.3.Final (Apache CXF 3.1.4) 2018-06-03 16:03:05,108 WARN [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0059: Class Path entry xercesImpl.jar in /G:/Development/Servers/last-wildfly/bin/content/ROOT.war/WEB-INF/lib/xalan-2.7.0.jar does not point to a valid jar for a Class-Path reference. 2018-06-03 16:03:05,109 WARN [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0059: Class Path entry xml-apis.jar in /G:/Development/Servers/last-wildfly/bin/content/ROOT.war/WEB-INF/lib/xalan-2.7.0.jar does not point to a valid jar for a Class-Path reference. 2018-06-03 16:03:05,109 WARN [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0059: Class Path entry serializer.jar in /G:/Development/Servers/last-wildfly/bin/content/ROOT.war/WEB-INF/lib/xalan-2.7.0.jar does not point to a valid jar for a Class-Path reference. 2018-06-03 16:03:05,880 INFO [org.jboss.as.jpa] (MSC service thread 1-1) WFLYJPA0002: Read persistence.xml for pvstreamPrimaryPU 2018-06-03 16:03:05,880 INFO [org.jboss.as.jpa] (MSC service thread 1-1) WFLYJPA0002: Read persistence.xml for hardwareDBPU 2018-06-03 16:03:05,880 INFO [org.jboss.as.jpa] (MSC service thread 1-1) WFLYJPA0002: Read persistence.xml for pvMigrationPU 2018-06-03 16:03:06,299 WARN [org.jboss.as.dependency.private] (MSC service thread 1-1) WFLYSRV0018: Deployment "deployment.ROOT.war" is using a private module ("org.infinispan:main") which may be changed or removed in future versions without notice. 2018-06-03 16:03:06,416 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 59) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'ROOT.war#pvstreamPrimaryPU' 2018-06-03 16:03:06,416 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 56) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'ROOT.war#pvMigrationPU' 2018-06-03 16:03:06,416 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 58) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'ROOT.war#hardwareDBPU' 2018-06-03 16:03:06,463 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 56) HHH000204: Processing PersistenceUnitInfo [ name: pvMigrationPU ...] 2018-06-03 16:03:06,463 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 59) HHH000204: Processing PersistenceUnitInfo [ name: pvstreamPrimaryPU ...] 2018-06-03 16:03:06,463 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 58) HHH000204: Processing PersistenceUnitInfo [ name: hardwareDBPU ...] 2018-06-03 16:03:06,613 INFO [org.jboss.weld.deployer] (MSC service thread 1-1) WFLYWELD0003: Processing weld deployment ROOT.war 2018-06-03 16:03:07,302 INFO [org.hibernate.Version] (ServerService Thread Pool -- 58) HHH000412: Hibernate Core {5.0.7.Final} 2018-06-03 16:03:07,303 INFO [org.hibernate.cfg.Environment] (ServerService Thread Pool -- 58) HHH000206: hibernate.properties not found 2018-06-03 16:03:07,304 INFO [org.hibernate.cfg.Environment] (ServerService Thread Pool -- 58) HHH000021: Bytecode provider name : javassist 2018-06-03 16:03:07,432 INFO [org.hibernate.orm.deprecation] (ServerService Thread Pool -- 56) HHH90000001: Found usage of deprecated setting for specifying Scanner [hibernate.ejb.resource_scanner]; use [hibernate.archive.scanner] instead 2018-06-03 16:03:07,432 INFO [org.hibernate.orm.deprecation] (ServerService Thread Pool -- 59) HHH90000001: Found usage of deprecated setting for specifying Scanner [hibernate.ejb.resource_scanner]; use [hibernate.archive.scanner] instead 2018-06-03 16:03:07,432 INFO [org.hibernate.orm.deprecation] (ServerService Thread Pool -- 58) HHH90000001: Found usage of deprecated setting for specifying Scanner [hibernate.ejb.resource_scanner]; use [hibernate.archive.scanner] instead 2018-06-03 16:03:07,454 INFO [org.hibernate.annotations.common.Version] (ServerService Thread Pool -- 59) HCANN000001: Hibernate Commons Annotations {5.0.1.Final} 2018-06-03 16:03:07,572 INFO [org.hibernate.validator.internal.util.Version] (MSC service thread 1-1) HV000001: Hibernate Validator 5.2.3.Final 2018-06-03 16:03:07,709 INFO [org.apache.deltaspike.core.impl.config.EnvironmentPropertyConfigSourceProvider] (MSC service thread 1-1) Custom config found by DeltaSpike. Name: 'META-INF/apache-deltaspike.properties', URL: 'vfs:/G:/Development/Servers/last-wildfly/bin/content/ROOT.war/WEB-INF/classes/META-INF/apache-deltaspike.properties' 2018-06-03 16:03:07,713 INFO [org.apache.deltaspike.core.util.ProjectStageProducer] (MSC service thread 1-1) Computed the following DeltaSpike ProjectStage: Production 2018-06-03 16:03:07,718 INFO [org.jboss.as.ejb3.deployment] (MSC service thread 1-1) WFLYEJB0473: JNDI bindings for session bean named 'EmailPeriodicTimer' in deployment unit 'deployment "ROOT.war"' are as follows: java:global/ROOT/EmailPeriodicTimer!com.pvstream.pilot.api.core.util.EmailPeriodicTimer java:app/ROOT/EmailPeriodicTimer!com.pvstream.pilot.api.core.util.EmailPeriodicTimer java:module/EmailPeriodicTimer!com.pvstream.pilot.api.core.util.EmailPeriodicTimer java:global/ROOT/EmailPeriodicTimer java:app/ROOT/EmailPeriodicTimer java:module/EmailPeriodicTimer 2018-06-03 16:03:07,719 INFO [org.jboss.as.ejb3.deployment] (MSC service thread 1-1) WFLYEJB0473: JNDI bindings for session bean named 'DatabaseMigration' in deployment unit 'deployment "ROOT.war"' are as follows: java:global/ROOT/DatabaseMigration!com.pvstream.pilot.api.core.util.DatabaseMigration java:app/ROOT/DatabaseMigration!com.pvstream.pilot.api.core.util.DatabaseMigration java:module/DatabaseMigration!com.pvstream.pilot.api.core.util.DatabaseMigration java:global/ROOT/DatabaseMigration java:app/ROOT/DatabaseMigration java:module/DatabaseMigration 2018-06-03 16:03:08,274 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-4) WFLYJCA0005: Deploying non-JDBC-compliant driver class com.mysql.cj.jdbc.Driver (version 6.0) 2018-06-03 16:03:08,275 WARN [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-4) WFLYJCA0003: Unable to instantiate driver class "org.olap4j.driver.xmla.XmlaOlap4jDriver": java.lang.NoSuchMethodException: org.olap4j.driver.xmla.XmlaOlap4jDriver.() 2018-06-03 16:03:08,276 INFO [org.jboss.weld.deployer] (MSC service thread 1-4) WFLYWELD0006: Starting Services for CDI deployment: ROOT.war 2018-06-03 16:03:08,460 INFO [org.jboss.weld.Version] (MSC service thread 1-4) WELD-000900: 2.3.2 (Final) 2018-06-03 16:03:08,495 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-7) WFLYJCA0018: Started Driver service with driver-name = ROOT.war_com.mysql.cj.jdbc.Driver_6_0 2018-06-03 16:03:08,496 INFO [org.jboss.weld.deployer] (MSC service thread 1-7) WFLYWELD0009: Starting weld service for deployment ROOT.war 2018-06-03 16:03:08,822 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 58) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'ROOT.war#hardwareDBPU' 2018-06-03 16:03:08,822 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 56) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'ROOT.war#pvstreamPrimaryPU' 2018-06-03 16:03:08,822 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 59) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'ROOT.war#pvMigrationPU' 2018-06-03 16:03:10,024 ERROR [stderr] (ServerService Thread Pool -- 58) Sun Jun 03 16:03:10 EEST 2018 WARN: Establishing SSL connection without server's identity verification is not recommended. According to MySQL 5.5.45+, 5.6.26+ and 5.7.6+ requirements SSL connection must be established by default if explicit option isn't set. For compliance with existing applications not using SSL the verifyServerCertificate property is set to 'false'. You need either to explicitly disable SSL by setting useSSL=false, or set useSSL=true and provide truststore for server certificate verification. 2018-06-03 16:03:10,197 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 56) HHH000400: Using dialect: org.hibernate.dialect.MySQL5InnoDBDialect 2018-06-03 16:03:10,197 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 59) HHH000400: Using dialect: org.hibernate.dialect.MySQL5InnoDBDialect 2018-06-03 16:03:10,273 INFO [org.hibernate.envers.boot.internal.EnversServiceImpl] (ServerService Thread Pool -- 59) Envers integration enabled? : true 2018-06-03 16:03:10,273 INFO [org.hibernate.envers.boot.internal.EnversServiceImpl] (ServerService Thread Pool -- 56) Envers integration enabled? : true 2018-06-03 16:03:10,365 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 58) HHH000400: Using dialect: org.hibernate.dialect.MySQL5InnoDBDialect 2018-06-03 16:03:10,372 INFO [org.hibernate.envers.boot.internal.EnversServiceImpl] (ServerService Thread Pool -- 58) Envers integration enabled? : true 2018-06-03 16:03:10,990 WARN [org.hibernate.boot.internal.SessionFactoryBuilderImpl] (ServerService Thread Pool -- 56) Unrecognized hbm2ddl_auto value : none. Supported values include create, create-drop, update, and validate. Ignoring 2018-06-03 16:03:11,636 INFO [org.hibernate.hql.internal.QueryTranslatorFactoryInitiator] (ServerService Thread Pool -- 56) HHH000397: Using ASTQueryTranslatorFactory 2018-06-03 16:03:12,030 INFO [org.jboss.weld.Event] (MSC service thread 1-6) WELD-000411: Observer method [BackedAnnotatedMethod] protected org.apache.deltaspike.core.impl.exclude.extension.ExcludeExtension.vetoBeans(@Observes ProcessAnnotatedType, BeanManager) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2018-06-03 16:03:12,034 INFO [org.jboss.weld.Event] (MSC service thread 1-6) WELD-000411: Observer method [BackedAnnotatedMethod] protected org.apache.deltaspike.core.impl.message.MessageBundleExtension.detectInterfaces(@Observes ProcessAnnotatedType) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2018-06-03 16:03:12,037 INFO [org.jboss.weld.Event] (MSC service thread 1-6) WELD-000411: Observer method [BackedAnnotatedMethod] protected org.apache.deltaspike.core.impl.interceptor.GlobalInterceptorExtension.promoteInterceptors(@Observes ProcessAnnotatedType, BeanManager) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2018-06-03 16:03:14,978 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (ServerService Thread Pool -- 73) EmailPeriodicTimer scheduled: ScheduleExpression[second=0,15,30,45 minute=* hour=* dayOfWeek=* dayOfMonth=* month=* year=* start=null end=null timezone=] 2018-06-03 16:03:15,399 INFO [io.undertow.servlet] (ServerService Thread Pool -- 73) Initializing Shiro environment 2018-06-03 16:03:15,399 INFO [org.apache.shiro.web.env.EnvironmentLoader] (ServerService Thread Pool -- 73) Starting Shiro environment initialization. 2018-06-03 16:03:16,387 INFO [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 73) WFLYCLINF0002: Started jpaResetPasswordRealm.authorizationCache cache from api container 2018-06-03 16:03:16,395 INFO [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 73) WFLYCLINF0002: Started jpaRealm.authorizationCache cache from api container 2018-06-03 16:03:16,395 INFO [org.apache.shiro.config.IniSecurityManagerFactory] (ServerService Thread Pool -- 73) Realms have been explicitly set on the SecurityManager instance - auto-setting of realms will not occur. 2018-06-03 16:03:16,399 INFO [org.apache.shiro.web.env.EnvironmentLoader] (ServerService Thread Pool -- 73) Shiro environment initialized in 999 ms. 2018-06-03 16:03:16,755 WARN [org.jboss.as.weld] (ServerService Thread Pool -- 73) WFLYWELD0052: Using deployment classloader to load proxy classes for module org.jboss.resteasy.resteasy-jaxrs:main. Package-private access will not work. To fix this the module should declare dependencies on [org.jboss.weld.core, org.jboss.weld.spi] 2018-06-03 16:03:17,829 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002225: Deploying javax.ws.rs.core.Application: class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,830 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.localization.LocalizationResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,830 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.InverterResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,830 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.electrical.ElectricalResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,830 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002205: Adding provider class com.pvstream.pilot.api.presentation.services.StringJsonMessageBodyWriter from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,831 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.layout.LayoutResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,831 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.ManufacturerResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,831 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.RackingResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,831 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.UserResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,831 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.BusinessResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,831 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.LocaleResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,831 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.CustomerResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,831 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.PVModuleResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,831 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.project.ProjectInfoResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.obstruction.ObstructionResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.shading.ShadingResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.businessmodel.BusinessModelResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.energyconsumption.EnergyUsageResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.FavoritePVModule.FavoritePVModuleResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.TestResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.Roof.RoofFaceResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.lead.LeadResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.FavoriteInverter.FavoriteInverterResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.Roof.RoofResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.AdminResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,834 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002205: Adding provider class com.pvstream.pilot.api.presentation.services.BooleanMessageBodyWriter from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,835 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.annotations.AnnotationsResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,835 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002205: Adding provider class com.pvstream.pilot.api.presentation.services.AppExceptionMapper from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,835 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002205: Adding provider class com.pvstream.pilot.api.presentation.services.StringMessageBodyWriter from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,835 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.AnonymousResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,836 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.EnergyConsumptionResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,836 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.ProjectResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,836 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.VersionResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,836 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.currency.CurrencyCodeService from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,836 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.leadgeneration.LeadGenerationWidgetResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,836 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.AuthResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,836 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.TimeZoneResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,836 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.proposal.ProposalResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,836 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.report.ReportResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:17,836 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 73) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.usermanagement.UserManagementResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:18,007 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 73) WFLYUT0021: Registered web context: / 2018-06-03 16:03:19,127 INFO [org.jboss.as.server] (Controller Boot Thread) WFLYSRV0010: Deployed "ROOT.war" (runtime-name : "ROOT.war") 2018-06-03 16:03:19,605 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-5) WFLYJCA0019: Stopped Driver service with driver-name = ROOT.war_com.mysql.cj.jdbc.Driver_6_0 2018-06-03 16:03:19,609 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 73) WFLYUT0022: Unregistered web context: / 2018-06-03 16:03:19,610 INFO [io.undertow.servlet] (ServerService Thread Pool -- 73) Cleaning up Shiro Environment 2018-06-03 16:03:19,622 INFO [org.jboss.weld.deployer] (MSC service thread 1-1) WFLYWELD0010: Stopping weld service for deployment ROOT.war 2018-06-03 16:03:19,637 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 73) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 'ROOT.war#hardwareDBPU' 2018-06-03 16:03:19,637 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 14) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 'ROOT.war#pvstreamPrimaryPU' 2018-06-03 16:03:19,637 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 17) WFLYJPA0011: Stopping Persistence Unit (phase 2 of 2) Service 'ROOT.war#pvMigrationPU' 2018-06-03 16:03:19,640 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 17) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 'ROOT.war#pvMigrationPU' 2018-06-03 16:03:19,640 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 73) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 'ROOT.war#hardwareDBPU' 2018-06-03 16:03:19,640 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 14) WFLYJPA0011: Stopping Persistence Unit (phase 1 of 2) Service 'ROOT.war#pvstreamPrimaryPU' 2018-06-03 16:03:21,972 INFO [org.jboss.as.server.deployment] (MSC service thread 1-3) WFLYSRV0028: Stopped deployment ROOT.war (runtime-name: ROOT.war) in 2372ms 2018-06-03 16:03:21,973 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0060: Http management interface listening on http://127.0.0.1:10090/management 2018-06-03 16:03:21,973 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0051: Admin console listening on http://127.0.0.1:10090 2018-06-03 16:03:21,973 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Full 10.0.0.Final (WildFly Core 2.0.10.Final) started in 39367ms - Started 297 of 655 services (457 services are lazy, passive or on-demand) 2018-06-03 16:03:22,045 INFO [org.jboss.as.server] (management-handler-thread - 4) WFLYSRV0009: Undeployed "ROOT.war" (runtime-name: "ROOT.war") 2018-06-03 16:03:22,137 INFO [org.jboss.as.server.deployment] (MSC service thread 1-4) WFLYSRV0027: Starting deployment of "ROOT.war" (runtime-name: "ROOT.war") 2018-06-03 16:03:27,845 WARN [org.jboss.as.server.deployment] (MSC service thread 1-2) WFLYSRV0059: Class Path entry xercesImpl.jar in /G:/Development/Servers/last-wildfly/bin/content/ROOT.war/WEB-INF/lib/xalan-2.7.0.jar does not point to a valid jar for a Class-Path reference. 2018-06-03 16:03:27,846 WARN [org.jboss.as.server.deployment] (MSC service thread 1-2) WFLYSRV0059: Class Path entry xml-apis.jar in /G:/Development/Servers/last-wildfly/bin/content/ROOT.war/WEB-INF/lib/xalan-2.7.0.jar does not point to a valid jar for a Class-Path reference. 2018-06-03 16:03:27,846 WARN [org.jboss.as.server.deployment] (MSC service thread 1-2) WFLYSRV0059: Class Path entry serializer.jar in /G:/Development/Servers/last-wildfly/bin/content/ROOT.war/WEB-INF/lib/xalan-2.7.0.jar does not point to a valid jar for a Class-Path reference. 2018-06-03 16:03:27,876 INFO [org.jboss.as.jpa] (MSC service thread 1-6) WFLYJPA0002: Read persistence.xml for pvstreamPrimaryPU 2018-06-03 16:03:27,877 INFO [org.jboss.as.jpa] (MSC service thread 1-6) WFLYJPA0002: Read persistence.xml for hardwareDBPU 2018-06-03 16:03:27,877 INFO [org.jboss.as.jpa] (MSC service thread 1-6) WFLYJPA0002: Read persistence.xml for pvMigrationPU 2018-06-03 16:03:28,045 WARN [org.jboss.as.dependency.private] (MSC service thread 1-1) WFLYSRV0018: Deployment "deployment.ROOT.war" is using a private module ("org.infinispan:main") which may be changed or removed in future versions without notice. 2018-06-03 16:03:28,062 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 17) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'ROOT.war#hardwareDBPU' 2018-06-03 16:03:28,062 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 73) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'ROOT.war#pvMigrationPU' 2018-06-03 16:03:28,062 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 14) WFLYJPA0010: Starting Persistence Unit (phase 1 of 2) Service 'ROOT.war#pvstreamPrimaryPU' 2018-06-03 16:03:28,062 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 17) HHH000204: Processing PersistenceUnitInfo [ name: hardwareDBPU ...] 2018-06-03 16:03:28,062 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 14) HHH000204: Processing PersistenceUnitInfo [ name: pvstreamPrimaryPU ...] 2018-06-03 16:03:28,062 INFO [org.hibernate.jpa.internal.util.LogHelper] (ServerService Thread Pool -- 73) HHH000204: Processing PersistenceUnitInfo [ name: pvMigrationPU ...] 2018-06-03 16:03:28,068 INFO [org.hibernate.orm.deprecation] (ServerService Thread Pool -- 14) HHH90000001: Found usage of deprecated setting for specifying Scanner [hibernate.ejb.resource_scanner]; use [hibernate.archive.scanner] instead 2018-06-03 16:03:28,068 INFO [org.hibernate.orm.deprecation] (ServerService Thread Pool -- 73) HHH90000001: Found usage of deprecated setting for specifying Scanner [hibernate.ejb.resource_scanner]; use [hibernate.archive.scanner] instead 2018-06-03 16:03:28,069 INFO [org.hibernate.orm.deprecation] (ServerService Thread Pool -- 17) HHH90000001: Found usage of deprecated setting for specifying Scanner [hibernate.ejb.resource_scanner]; use [hibernate.archive.scanner] instead 2018-06-03 16:03:28,089 INFO [org.jboss.weld.deployer] (MSC service thread 1-7) WFLYWELD0003: Processing weld deployment ROOT.war 2018-06-03 16:03:28,113 INFO [org.apache.deltaspike.core.impl.config.EnvironmentPropertyConfigSourceProvider] (MSC service thread 1-7) Custom config found by DeltaSpike. Name: 'META-INF/apache-deltaspike.properties', URL: 'vfs:/G:/Development/Servers/last-wildfly/bin/content/ROOT.war/WEB-INF/classes/META-INF/apache-deltaspike.properties' 2018-06-03 16:03:28,116 INFO [org.apache.deltaspike.core.util.ProjectStageProducer] (MSC service thread 1-7) Computed the following DeltaSpike ProjectStage: Production 2018-06-03 16:03:28,120 INFO [org.jboss.as.ejb3.deployment] (MSC service thread 1-7) WFLYEJB0473: JNDI bindings for session bean named 'EmailPeriodicTimer' in deployment unit 'deployment "ROOT.war"' are as follows: java:global/ROOT/EmailPeriodicTimer!com.pvstream.pilot.api.core.util.EmailPeriodicTimer java:app/ROOT/EmailPeriodicTimer!com.pvstream.pilot.api.core.util.EmailPeriodicTimer java:module/EmailPeriodicTimer!com.pvstream.pilot.api.core.util.EmailPeriodicTimer java:global/ROOT/EmailPeriodicTimer java:app/ROOT/EmailPeriodicTimer java:module/EmailPeriodicTimer 2018-06-03 16:03:28,121 INFO [org.jboss.as.ejb3.deployment] (MSC service thread 1-7) WFLYEJB0473: JNDI bindings for session bean named 'DatabaseMigration' in deployment unit 'deployment "ROOT.war"' are as follows: java:global/ROOT/DatabaseMigration!com.pvstream.pilot.api.core.util.DatabaseMigration java:app/ROOT/DatabaseMigration!com.pvstream.pilot.api.core.util.DatabaseMigration java:module/DatabaseMigration!com.pvstream.pilot.api.core.util.DatabaseMigration java:global/ROOT/DatabaseMigration java:app/ROOT/DatabaseMigration java:module/DatabaseMigration 2018-06-03 16:03:28,163 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-7) WFLYJCA0005: Deploying non-JDBC-compliant driver class com.mysql.cj.jdbc.Driver (version 6.0) 2018-06-03 16:03:28,164 WARN [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-7) WFLYJCA0003: Unable to instantiate driver class "org.olap4j.driver.xmla.XmlaOlap4jDriver": java.lang.NoSuchMethodException: org.olap4j.driver.xmla.XmlaOlap4jDriver.() 2018-06-03 16:03:28,164 INFO [org.jboss.weld.deployer] (MSC service thread 1-7) WFLYWELD0006: Starting Services for CDI deployment: ROOT.war 2018-06-03 16:03:28,167 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-1) WFLYJCA0018: Started Driver service with driver-name = ROOT.war_com.mysql.cj.jdbc.Driver_6_0 2018-06-03 16:03:28,168 INFO [org.jboss.weld.deployer] (MSC service thread 1-5) WFLYWELD0009: Starting weld service for deployment ROOT.war 2018-06-03 16:03:29,169 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 17) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'ROOT.war#hardwareDBPU' 2018-06-03 16:03:29,171 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 17) HHH000400: Using dialect: org.hibernate.dialect.MySQL5InnoDBDialect 2018-06-03 16:03:29,175 INFO [org.hibernate.envers.boot.internal.EnversServiceImpl] (ServerService Thread Pool -- 17) Envers integration enabled? : true 2018-06-03 16:03:29,234 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 73) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'ROOT.war#pvMigrationPU' 2018-06-03 16:03:29,235 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 73) HHH000400: Using dialect: org.hibernate.dialect.MySQL5InnoDBDialect 2018-06-03 16:03:29,238 INFO [org.jboss.as.jpa] (ServerService Thread Pool -- 14) WFLYJPA0010: Starting Persistence Unit (phase 2 of 2) Service 'ROOT.war#pvstreamPrimaryPU' 2018-06-03 16:03:29,238 INFO [org.hibernate.envers.boot.internal.EnversServiceImpl] (ServerService Thread Pool -- 73) Envers integration enabled? : true 2018-06-03 16:03:29,238 INFO [org.hibernate.dialect.Dialect] (ServerService Thread Pool -- 14) HHH000400: Using dialect: org.hibernate.dialect.MySQL5InnoDBDialect 2018-06-03 16:03:29,242 INFO [org.hibernate.envers.boot.internal.EnversServiceImpl] (ServerService Thread Pool -- 14) Envers integration enabled? : true 2018-06-03 16:03:29,306 WARN [org.hibernate.boot.internal.SessionFactoryBuilderImpl] (ServerService Thread Pool -- 14) Unrecognized hbm2ddl_auto value : none. Supported values include create, create-drop, update, and validate. Ignoring 2018-06-03 16:03:29,473 INFO [org.hibernate.hql.internal.QueryTranslatorFactoryInitiator] (ServerService Thread Pool -- 14) HHH000397: Using ASTQueryTranslatorFactory 2018-06-03 16:03:29,505 INFO [org.jboss.weld.Event] (MSC service thread 1-7) WELD-000411: Observer method [BackedAnnotatedMethod] protected org.apache.deltaspike.core.impl.message.MessageBundleExtension.detectInterfaces(@Observes ProcessAnnotatedType) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2018-06-03 16:03:29,512 INFO [org.jboss.weld.Event] (MSC service thread 1-7) WELD-000411: Observer method [BackedAnnotatedMethod] protected org.apache.deltaspike.core.impl.exclude.extension.ExcludeExtension.vetoBeans(@Observes ProcessAnnotatedType, BeanManager) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2018-06-03 16:03:29,513 INFO [org.jboss.weld.Event] (MSC service thread 1-7) WELD-000411: Observer method [BackedAnnotatedMethod] protected org.apache.deltaspike.core.impl.interceptor.GlobalInterceptorExtension.promoteInterceptors(@Observes ProcessAnnotatedType, BeanManager) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 2018-06-03 16:03:30,266 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (ServerService Thread Pool -- 12) EmailPeriodicTimer scheduled: ScheduleExpression[second=0,15,30,45 minute=* hour=* dayOfWeek=* dayOfMonth=* month=* year=* start=null end=null timezone=] 2018-06-03 16:03:30,277 INFO [io.undertow.servlet] (ServerService Thread Pool -- 12) Initializing Shiro environment 2018-06-03 16:03:30,278 INFO [org.apache.shiro.web.env.EnvironmentLoader] (ServerService Thread Pool -- 12) Starting Shiro environment initialization. 2018-06-03 16:03:30,340 INFO [org.apache.shiro.config.IniSecurityManagerFactory] (ServerService Thread Pool -- 12) Realms have been explicitly set on the SecurityManager instance - auto-setting of realms will not occur. 2018-06-03 16:03:30,344 INFO [org.apache.shiro.web.env.EnvironmentLoader] (ServerService Thread Pool -- 12) Shiro environment initialized in 66 ms. 2018-06-03 16:03:30,355 WARN [org.jboss.as.weld] (ServerService Thread Pool -- 12) WFLYWELD0052: Using deployment classloader to load proxy classes for module org.jboss.resteasy.resteasy-jaxrs:main. Package-private access will not work. To fix this the module should declare dependencies on [org.jboss.weld.core, org.jboss.weld.spi] 2018-06-03 16:03:30,389 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002225: Deploying javax.ws.rs.core.Application: class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.ManufacturerResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.leadgeneration.LeadGenerationWidgetResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.VersionResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.shading.ShadingResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.LocaleResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.RackingResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.UserResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.obstruction.ObstructionResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.electrical.ElectricalResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.layout.LayoutResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002205: Adding provider class com.pvstream.pilot.api.presentation.services.StringMessageBodyWriter from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.Roof.RoofResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,390 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.BusinessResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.AdminResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002205: Adding provider class com.pvstream.pilot.api.presentation.services.BooleanMessageBodyWriter from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.Roof.RoofFaceResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.ProjectResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.report.ReportResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.lead.LeadResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.energyconsumption.EnergyUsageResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.AnonymousResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.PVModuleResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.localization.LocalizationResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.annotations.AnnotationsResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.project.ProjectInfoResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.TestResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.EnergyConsumptionResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.businessmodel.BusinessModelResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.FavoritePVModule.FavoritePVModuleResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.currency.CurrencyCodeService from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.proposal.ProposalResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.FavoriteInverter.FavoriteInverterResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.CustomerResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002205: Adding provider class com.pvstream.pilot.api.presentation.services.AppExceptionMapper from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,391 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002205: Adding provider class com.pvstream.pilot.api.presentation.services.StringJsonMessageBodyWriter from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,392 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.InverterResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,392 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.TimeZoneResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,392 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.AuthResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,392 INFO [org.jboss.resteasy.resteasy_jaxrs.i18n] (ServerService Thread Pool -- 12) RESTEASY002200: Adding class resource com.pvstream.pilot.api.presentation.services.usermanagement.UserManagementResource from Application class com.pvstream.pilot.api.presentation.services.ApplicationConfig$Proxy$_$$_WeldClientProxy 2018-06-03 16:03:30,435 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 12) WFLYUT0021: Registered web context: / 2018-06-03 16:03:30,476 INFO [org.jboss.as.server] (management-handler-thread - 4) WFLYSRV0010: Deployed "ROOT.war" (runtime-name : "ROOT.war") 2018-06-03 16:03:45,005 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:03:45,073 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:04:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:04:00,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:04:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:04:15,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:04:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:04:30,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:04:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:04:45,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:05:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:05:00,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:05:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:05:15,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:05:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:05:30,015 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:05:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:05:45,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:06:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:06:00,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:06:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:06:15,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:06:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:06:30,008 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:06:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:06:45,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:06:51,582 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-1) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:06:51,837 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-2) REST Request - [HTTP METHOD: GET] [PATH INFO: /anonymous/localization/default] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:06:54,954 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-3) REST Request - [HTTP METHOD: POST] [PATH INFO: /auth/login] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:06:55,164 INFO [com.pvstream.pilot.api.core.security.JpaRealm] (default task-3) >>>>>>>>$2a$10$rDA8UE9VldiTflUrtY28LubHO3m3IX/5modMTS8Zx0LDl4JNcROei 2018-06-03 16:06:55,164 INFO [com.pvstream.pilot.api.core.security.JpaRealm] (default task-3) >>>>>>>>Power$14 2018-06-03 16:06:55,525 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-4) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:06:55,694 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-5) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:06:55,694 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-6) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:06:56,101 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-7) REST Request - [HTTP METHOD: GET] [PATH INFO: /projectInfo/last/5/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:06:56,111 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-8) REST Request - [HTTP METHOD: GET] [PATH INFO: /projectInfo/list/1/10/modifiedOn/DESC/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:06:56,116 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-7) SELECT e FROM Project e LEFT JOIN FETCH e.createdBy u WHERE e.businessAccount.workspaceId = :workspaceId ORDER BY e.modifiedOn DESC 2018-06-03 16:06:56,116 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-8) SELECT e FROM Project e LEFT JOIN FETCH e.createdBy u WHERE e.businessAccount.workspaceId = :workspaceId ORDER BY e.modifiedOn DESC 2018-06-03 16:06:56,142 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-7) SELECT count(e.id) FROM Project e WHERE e.businessAccount.workspaceId = :workspaceId 2018-06-03 16:06:56,142 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-8) SELECT count(e.id) FROM Project e WHERE e.businessAccount.workspaceId = :workspaceId 2018-06-03 16:07:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:07:00,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:07:00,147 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-9) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:00,148 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-10) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:00,354 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-11) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:00,440 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-12) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:00,507 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-12) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:07:00,508 INFO [org.hibernate.hql.internal.QueryTranslatorFactoryInitiator] (default task-12) HHH000397: Using ASTQueryTranslatorFactory 2018-06-03 16:07:00,648 ERROR [stderr] (default task-11) Sun Jun 03 16:07:00 EEST 2018 WARN: Establishing SSL connection without server's identity verification is not recommended. According to MySQL 5.5.45+, 5.6.26+ and 5.7.6+ requirements SSL connection must be established by default if explicit option isn't set. For compliance with existing applications not using SSL the verifyServerCertificate property is set to 'false'. You need either to explicitly disable SSL by setting useSSL=false, or set useSSL=true and provide truststore for server certificate verification. 2018-06-03 16:07:00,742 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-13) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:00,807 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-13) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:07:00,912 ERROR [stderr] (default task-13) Sun Jun 03 16:07:00 EEST 2018 WARN: Establishing SSL connection without server's identity verification is not recommended. According to MySQL 5.5.45+, 5.6.26+ and 5.7.6+ requirements SSL connection must be established by default if explicit option isn't set. For compliance with existing applications not using SSL the verifyServerCertificate property is set to 'false'. You need either to explicitly disable SSL by setting useSSL=false, or set useSSL=true and provide truststore for server certificate verification. 2018-06-03 16:07:01,329 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-14) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:01,331 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-15) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:01,337 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-16) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:01,404 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-14) ==> Calling PVWATTS API - Query weather data: lat=37.528&lon=-122.293&radius=300&all=1 2018-06-03 16:07:01,404 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-14) PVWatts weather query request URL: https://developer.nrel.gov/api/solar/data_query/v1.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&lat=37.528&lon=-122.293&radius=300&all=1 2018-06-03 16:07:01,410 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-16) ==> Calling PVWATTS API - Query weather data: lat=37.528&lon=-122.293&radius=300&all=1 2018-06-03 16:07:01,411 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-16) PVWatts weather query request URL: https://developer.nrel.gov/api/solar/data_query/v1.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&lat=37.528&lon=-122.293&radius=300&all=1 2018-06-03 16:07:01,484 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-15) ==> Calling PVWATTS API - Query weather data: lat=37.528&lon=-122.293&radius=300&all=1 2018-06-03 16:07:01,484 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-15) PVWatts weather query request URL: https://developer.nrel.gov/api/solar/data_query/v1.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&lat=37.528&lon=-122.293&radius=300&all=1 2018-06-03 16:07:01,637 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-17) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:01,639 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-17) >>> Received request to shadow pies for entire project 2018-06-03 16:07:02,171 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-18) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:02,513 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-19) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:03,436 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-15) PVWatts weather query status code: OK (200) 2018-06-03 16:07:03,449 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-15) ==> Closes weather station: null 2018-06-03 16:07:03,451 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-15) PVWatts simulation service request URL: https://developer.nrel.gov/api/pvwatts/v5.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&system_capacity=1&module_type=0&losses=5&array_type=0&tilt=0.00000&azimuth=0.00000&file_id=1-724940&timeframe=hourly&dc_ac_ratio=1.100000&gcr=1&inv_eff=96&roof_face_id=1&roof_face_area=100.000 2018-06-03 16:07:03,557 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-16) PVWatts weather query status code: OK (200) 2018-06-03 16:07:03,562 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-16) ==> Closes weather station: null 2018-06-03 16:07:03,562 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-16) PVWatts simulation service request URL: https://developer.nrel.gov/api/pvwatts/v5.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&system_capacity=1&module_type=0&losses=5&array_type=0&tilt=0.00000&azimuth=0.00000&file_id=1-724940&timeframe=hourly&dc_ac_ratio=1.100000&gcr=1&inv_eff=96&roof_face_id=1&roof_face_area=100.000 2018-06-03 16:07:04,076 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-14) PVWatts weather query status code: OK (200) 2018-06-03 16:07:04,078 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-14) ==> Closes weather station: null 2018-06-03 16:07:04,078 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-14) PVWatts simulation service request URL: https://developer.nrel.gov/api/pvwatts/v5.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&system_capacity=1&module_type=0&losses=5&array_type=0&tilt=0.00000&azimuth=0.00000&file_id=1-724940&timeframe=hourly&dc_ac_ratio=1.100000&gcr=1&inv_eff=96&roof_face_id=1&roof_face_area=100.000 2018-06-03 16:07:04,785 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-15) PVWatts simulation service status code: OK (200) 2018-06-03 16:07:05,182 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-16) PVWatts simulation service status code: OK (200) 2018-06-03 16:07:05,191 INFO [com.pvstream.pilot.api.core.bl.appservice.irradiance.IrradianceAppServiceImpl] (default task-15) Simulation status code: OK (200) 2018-06-03 16:07:05,430 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-20) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:05,576 INFO [com.pvstream.pilot.api.core.bl.appservice.irradiance.IrradianceAppServiceImpl] (default task-16) Simulation status code: OK (200) 2018-06-03 16:07:05,714 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-14) PVWatts simulation service status code: OK (200) 2018-06-03 16:07:05,741 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-21) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:06,099 INFO [com.pvstream.pilot.api.core.bl.appservice.irradiance.IrradianceAppServiceImpl] (default task-14) Simulation status code: OK (200) 2018-06-03 16:07:06,546 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-22) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:10,888 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-23) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:10,946 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-23) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:07:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:07:15,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:07:15,388 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-24) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:15,445 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-24) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:07:24,799 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-25) REST Request - [HTTP METHOD: POST] [PATH INFO: /layout/generate] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:24,807 INFO [com.pvstream.pilot.api.presentation.services.layout.LayoutResource] (default task-25) Received request for sub arrays generation 2018-06-03 16:07:25,224 INFO [com.pvstream.pilot.api.presentation.services.layout.LayoutResource] (default task-25) SubArrays for project with id 4170 has been generated 2018-06-03 16:07:25,556 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-26) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/id/18] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:25,557 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-27) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:25,805 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-28) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:26,040 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-29) REST Request - [HTTP METHOD: PUT] [PATH INFO: /layout] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:26,042 INFO [com.pvstream.pilot.api.presentation.services.layout.LayoutResource] (default task-29) Received request for layout update 2018-06-03 16:07:26,132 INFO [com.pvstream.pilot.api.presentation.services.layout.LayoutResource] (default task-29) Layout with id 33722 has been updated 2018-06-03 16:07:26,247 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-30) REST Request - [HTTP METHOD: POST] [PATH INFO: /electrical] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:26,251 INFO [com.pvstream.pilot.api.core.bl.workflow.electrical.UpdateElectricalDataWorkflowImpl] (default task-30) Updating electrical data 2018-06-03 16:07:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:07:30,018 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:07:31,935 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-31) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:31,998 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-31) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:07:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:07:45,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:07:50,110 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-32) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:07:50,174 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-32) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:08:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:08:00,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:08:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:08:15,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:08:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:08:30,012 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:08:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:08:45,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:09:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:09:00,012 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:09:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:09:15,008 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:09:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:09:30,003 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:09:43,911 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-33) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:44,070 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-34) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:44,071 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-35) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:44,206 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-36) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:44,206 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-37) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:44,433 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-38) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:44,750 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-40) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:44,750 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-39) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:44,813 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-39) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:09:44,813 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-40) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:09:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:09:45,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:09:45,195 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-41) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:45,198 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-42) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:45,200 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-43) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:45,201 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-44) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:45,202 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-44) >>> Received request to shadow pies for entire project 2018-06-03 16:09:45,518 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-45) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:45,530 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-46) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:45,747 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-47) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:45,760 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-48) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:45,838 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-49) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:09:45,907 ERROR [stderr] (default task-48) Sun Jun 03 16:09:45 EEST 2018 WARN: Establishing SSL connection without server's identity verification is not recommended. According to MySQL 5.5.45+, 5.6.26+ and 5.7.6+ requirements SSL connection must be established by default if explicit option isn't set. For compliance with existing applications not using SSL the verifyServerCertificate property is set to 'false'. You need either to explicitly disable SSL by setting useSSL=false, or set useSSL=true and provide truststore for server certificate verification. 2018-06-03 16:09:45,984 ERROR [stderr] (default task-49) Sun Jun 03 16:09:45 EEST 2018 WARN: Establishing SSL connection without server's identity verification is not recommended. According to MySQL 5.5.45+, 5.6.26+ and 5.7.6+ requirements SSL connection must be established by default if explicit option isn't set. For compliance with existing applications not using SSL the verifyServerCertificate property is set to 'false'. You need either to explicitly disable SSL by setting useSSL=false, or set useSSL=true and provide truststore for server certificate verification. 2018-06-03 16:10:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:10:00,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:10:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:10:15,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:10:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:10:30,005 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:10:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:10:45,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:11:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:11:00,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:11:04,064 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-50) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:04,222 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-51) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:04,222 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-52) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:04,260 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-54) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:04,260 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-53) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:04,547 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-55) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:04,809 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-56) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:04,812 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-57) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:04,872 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-57) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:11:04,872 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-56) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:11:05,263 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-59) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:05,263 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-58) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:05,264 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-60) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:05,266 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-61) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:05,267 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-61) >>> Received request to shadow pies for entire project 2018-06-03 16:11:05,606 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-62) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:05,930 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-63) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:05,954 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-64) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:06,409 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-65) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:06,423 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-66) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:11:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:11:15,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:11:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:11:30,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:11:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:11:45,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:12:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:12:00,012 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:12:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:12:15,008 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:12:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:12:30,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:12:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:12:45,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:13:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:13:00,004 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:13:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:13:15,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:13:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:13:30,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:13:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:13:45,012 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:14:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:14:00,008 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:14:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:14:15,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:14:19,029 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-67) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:19,091 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-67) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:14:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:14:30,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:14:38,930 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-68) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:39,087 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-69) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:39,088 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-70) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:39,122 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-71) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:39,122 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-72) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:39,394 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-73) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:39,666 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-74) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:39,669 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-75) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:39,726 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-75) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:14:39,726 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-74) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:14:40,080 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-76) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:40,080 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-77) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:40,084 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-78) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:40,084 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-79) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:40,085 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-79) >>> Received request to shadow pies for entire project 2018-06-03 16:14:40,420 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-80) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:40,498 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-81) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:40,751 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-82) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:40,752 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-83) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:41,218 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-84) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:14:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:14:45,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:15:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:15:00,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:15:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:15:15,008 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:15:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:15:30,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:15:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:15:45,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:15:51,226 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-85) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:51,378 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-86) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:51,380 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-87) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:51,427 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-88) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:51,427 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-89) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:51,680 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-90) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:51,989 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-92) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:51,989 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-91) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:52,050 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-92) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:15:52,050 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-91) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:15:52,425 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-93) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:52,425 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-94) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:52,425 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-95) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:52,427 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-96) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:52,428 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-96) >>> Received request to shadow pies for entire project 2018-06-03 16:15:52,761 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-97) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:52,767 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-98) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:52,927 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-99) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:52,943 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-100) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:15:53,255 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-101) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:16:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:16:00,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:16:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:16:15,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:16:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:16:30,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:16:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:16:45,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:17:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:17:00,015 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:17:11,908 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-102) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:12,062 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-103) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:12,062 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-104) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:12,104 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-106) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:12,104 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-105) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:12,358 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-107) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:12,655 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-108) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:12,656 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-109) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:12,716 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-109) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:17:12,716 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-108) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:17:13,096 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-110) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:13,096 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-111) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:13,098 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-112) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:13,101 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-113) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:13,102 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-113) >>> Received request to shadow pies for entire project 2018-06-03 16:17:13,451 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-114) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:13,458 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-115) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:13,606 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-116) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:13,741 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-117) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:14,217 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-118) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:17:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:17:15,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:17:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:17:30,005 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:17:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:17:45,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:18:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:18:00,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:18:10,032 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-119) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:10,189 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-120) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:10,190 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-121) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:10,229 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-122) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:10,229 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-123) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:10,529 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-124) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:10,847 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-126) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:10,847 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-125) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:10,908 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-125) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:18:10,908 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-126) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:18:11,253 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-127) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:11,253 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-128) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:11,253 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-129) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:11,255 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-130) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:11,256 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-130) >>> Received request to shadow pies for entire project 2018-06-03 16:18:11,583 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-131) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:11,597 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-132) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:11,819 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-133) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:11,912 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-134) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:11,912 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-135) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:18:15,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:18:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:18:30,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:18:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:18:45,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:18:45,442 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-136) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:45,633 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-137) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:45,634 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-138) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:45,683 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-139) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:45,683 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-140) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:45,989 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-141) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:46,305 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-143) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:46,305 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-142) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:46,377 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-142) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:18:46,377 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-143) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:18:46,771 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-146) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:46,771 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-144) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:46,771 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-147) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:46,771 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-145) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:46,773 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-147) >>> Received request to shadow pies for entire project 2018-06-03 16:18:47,104 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-148) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:47,110 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-149) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:47,309 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-150) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:47,324 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-151) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:18:47,426 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-152) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:19:00,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:19:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:19:15,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:19:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:19:30,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:19:31,199 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-153) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:31,367 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-155) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:31,367 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-154) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:31,410 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-157) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:31,410 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-156) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:31,654 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-158) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:31,954 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-159) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:31,954 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-160) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:32,015 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-160) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:19:32,015 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-159) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:19:32,357 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-161) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:32,357 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-162) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:32,358 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-163) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:32,361 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-164) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:32,362 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-164) >>> Received request to shadow pies for entire project 2018-06-03 16:19:32,696 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-165) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:32,718 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-166) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:33,025 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-167) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:33,039 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-168) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:33,626 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-169) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:40,406 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-170) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:40,463 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-170) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:19:44,273 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-171) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:19:44,332 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-171) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:19:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:19:45,012 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:20:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:20:00,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:20:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:20:15,015 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:20:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:20:30,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:20:38,067 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-172) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:38,219 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-173) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:38,227 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-174) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:38,287 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-175) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:38,291 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-176) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:38,523 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-177) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:38,847 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-178) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:38,850 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-179) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:38,902 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-178) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:20:38,911 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-179) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:20:39,352 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-180) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:39,353 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-181) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:39,353 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-182) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:39,356 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-183) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:39,357 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-183) >>> Received request to shadow pies for entire project 2018-06-03 16:20:39,697 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-185) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:39,697 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-184) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:39,865 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-186) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:40,246 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-187) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:40,246 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-188) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:20:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:20:45,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:21:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:21:00,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:21:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:21:15,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:21:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:21:30,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:21:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:21:45,005 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:22:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:22:00,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:22:11,483 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-189) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:11,636 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-190) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:11,639 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-191) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:11,672 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-193) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:11,672 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-192) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:11,954 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-194) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:12,233 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-195) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:12,235 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-196) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:12,291 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-195) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:22:12,298 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-196) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:22:12,659 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-197) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:12,662 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-199) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:12,662 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-198) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:12,662 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-200) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:12,663 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-200) >>> Received request to shadow pies for entire project 2018-06-03 16:22:12,992 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-201) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:13,020 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-202) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:13,337 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-203) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:13,351 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-204) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:13,362 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-205) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:22:15,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:22:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:22:30,005 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:22:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:22:45,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:22:55,889 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-206) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:56,045 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-207) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:56,047 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-208) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:56,089 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-209) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:56,089 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-210) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:56,321 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-211) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:56,641 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-212) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:56,641 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-213) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:56,698 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-213) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:22:56,698 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-212) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:22:57,056 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-214) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33989/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:57,058 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-215) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33990/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:57,058 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-216) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33991/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:57,061 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-217) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4170] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:57,062 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-217) >>> Received request to shadow pies for entire project 2018-06-03 16:22:57,397 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-218) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4849] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:57,419 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-219) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/US] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:57,596 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-220) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:57,725 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-221) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:22:58,264 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-222) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/id/2511] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:23:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:23:00,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:23:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:23:15,005 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:23:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:23:30,011 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:23:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:23:45,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:24:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:24:00,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:24:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:24:15,008 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:24:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:24:30,004 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:24:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:24:45,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:24:45,199 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-223) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:24:45,199 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-224) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:24:45,447 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-225) REST Request - [HTTP METHOD: GET] [PATH INFO: /user] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:25:00,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:25:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:25:15,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:25:24,219 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-226) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/logout] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:24,469 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-227) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:24,674 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-228) REST Request - [HTTP METHOD: GET] [PATH INFO: /anonymous/localization/default] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:25,741 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-229) REST Request - [HTTP METHOD: POST] [PATH INFO: /auth/login] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:25,892 INFO [com.pvstream.pilot.api.core.security.JpaRealm] (default task-229) >>>>>>>>$2a$10$rDA8UE9VldiTflUrtY28LubHO3m3IX/5modMTS8Zx0LDl4JNcROei 2018-06-03 16:25:25,893 INFO [com.pvstream.pilot.api.core.security.JpaRealm] (default task-229) >>>>>>>>Power$14 2018-06-03 16:25:26,258 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-230) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:26,707 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-231) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:26,707 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-232) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:26,955 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-233) REST Request - [HTTP METHOD: GET] [PATH INFO: /projectInfo/last/5/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:26,956 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-233) SELECT e FROM Project e LEFT JOIN FETCH e.createdBy u WHERE e.businessAccount.workspaceId = :workspaceId ORDER BY e.modifiedOn DESC 2018-06-03 16:25:26,966 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-233) SELECT count(e.id) FROM Project e WHERE e.businessAccount.workspaceId = :workspaceId 2018-06-03 16:25:27,067 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-234) REST Request - [HTTP METHOD: GET] [PATH INFO: /projectInfo/list/1/10/modifiedOn/DESC/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:27,068 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-234) SELECT e FROM Project e LEFT JOIN FETCH e.createdBy u WHERE e.businessAccount.workspaceId = :workspaceId ORDER BY e.modifiedOn DESC 2018-06-03 16:25:27,076 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-234) SELECT count(e.id) FROM Project e WHERE e.businessAccount.workspaceId = :workspaceId 2018-06-03 16:25:27,923 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-236) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:27,923 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-235) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:27,998 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-237) REST Request - [HTTP METHOD: GET] [PATH INFO: /user] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:25:30,008 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:25:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:25:45,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:25:55,742 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-238) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/logout] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:55,991 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-239) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:56,189 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-240) REST Request - [HTTP METHOD: GET] [PATH INFO: /anonymous/localization/default] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:59,305 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-241) REST Request - [HTTP METHOD: POST] [PATH INFO: /auth/login] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:25:59,452 INFO [com.pvstream.pilot.api.core.security.JpaRealm] (default task-241) >>>>>>>>$2a$10$HFCL2tpxlz2JxHwBOu3UCuWPWf.syIjtsD6e1RdD0Y2kfa9q2eOxi 2018-06-03 16:25:59,452 INFO [com.pvstream.pilot.api.core.security.JpaRealm] (default task-241) >>>>>>>>Power$14 2018-06-03 16:25:59,990 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-242) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:26:00,015 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:26:00,240 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-243) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:00,451 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-244) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:00,511 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-245) REST Request - [HTTP METHOD: GET] [PATH INFO: /projectInfo/last/5/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:00,512 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-245) SELECT e FROM Project e LEFT JOIN FETCH e.createdBy u WHERE e.businessAccountId = :businessAccountId ORDER BY e.modifiedOn DESC 2018-06-03 16:26:00,527 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-245) SELECT count(e.id) FROM Project e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:26:00,818 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-246) REST Request - [HTTP METHOD: GET] [PATH INFO: /projectInfo/list/1/10/modifiedOn/DESC/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:00,819 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-246) SELECT e FROM Project e LEFT JOIN FETCH e.createdBy u WHERE e.businessAccountId = :businessAccountId ORDER BY e.modifiedOn DESC 2018-06-03 16:26:00,833 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-246) SELECT count(e.id) FROM Project e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:26:02,104 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-247) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:02,104 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-248) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:02,334 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-249) REST Request - [HTTP METHOD: GET] [PATH INFO: /user] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:03,858 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-250) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:04,159 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-251) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:04,522 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-252) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessaccount] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:04,525 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-253) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessaccount/logo] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:04,567 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-254) REST Request - [HTTP METHOD: POST] [PATH INFO: /usermanagement/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:04,591 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-254) SELECT e FROM UserAccount e WHERE 1=1 AND e.businessAccountId=:businessAccountId ORDER BY userName DESC 2018-06-03 16:26:04,602 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-254) SELECT COUNT(e.id) FROM UserAccount e WHERE 1=1 AND e.businessAccountId=:businessAccountId 2018-06-03 16:26:05,332 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-255) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:05,632 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-256) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:05,985 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-1) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:05,988 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-2) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:05,988 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-3) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:05,991 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-4) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:05,992 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-5) REST Request - [HTTP METHOD: GET] [PATH INFO: /favoritepvmodule/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:05,992 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-6) REST Request - [HTTP METHOD: GET] [PATH INFO: /favoriteinverter/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:05,997 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-5) SELECT e FROM FavoritePVModule e WHERE e.businessAccountId = :businessAccountId ORDER BY e.manufacturer ASC 2018-06-03 16:26:05,998 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-6) SELECT e FROM FavoriteInverter e WHERE e.businessAccountId = :businessAccountId ORDER BY e.manufacturer ASC 2018-06-03 16:26:06,020 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-6) SELECT COUNT(e.id) FROM FavoriteInverter e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:26:06,060 INFO [com.pvstream.pilot.api.presentation.services.PVModuleResource] (default task-1) Received request for PVModule search 2018-06-03 16:26:06,060 INFO [com.pvstream.pilot.api.presentation.services.InverterResource] (default task-2) Received request for Inverter search 2018-06-03 16:26:06,060 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-4) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:06,098 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-5) SELECT COUNT(e.id) FROM FavoritePVModule e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:26:06,119 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-4) SELECT COUNT(e.pvModuleId) FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:06,180 INFO [com.pvstream.pilot.api.presentation.services.InverterResource] (default task-2) Inverter search - ok 2018-06-03 16:26:06,258 INFO [com.pvstream.pilot.api.presentation.services.PVModuleResource] (default task-1) PVModule search - ok 2018-06-03 16:26:06,313 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-8) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:06,374 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-8) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:06,424 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-8) SELECT COUNT(e.inverterId) FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:07,361 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-7) REST Request - [HTTP METHOD: POST] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:07,363 INFO [com.pvstream.pilot.api.core.bl.workflow.businessmodel.UpdateBusinessModelWorkflowImpl] (default task-7) Updating Business model properties 2018-06-03 16:26:09,057 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-9) REST Request - [HTTP METHOD: POST] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:09,057 INFO [com.pvstream.pilot.api.core.bl.workflow.businessmodel.UpdateBusinessModelWorkflowImpl] (default task-9) Updating Business model properties 2018-06-03 16:26:13,248 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-10) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,408 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-11) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,411 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-17) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,446 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-18) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,447 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-19) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,524 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-12) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,586 INFO [com.pvstream.pilot.api.presentation.services.PVModuleResource] (default task-12) Received request for PVModule search 2018-06-03 16:26:13,739 INFO [com.pvstream.pilot.api.presentation.services.PVModuleResource] (default task-12) PVModule search - ok 2018-06-03 16:26:13,826 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-13) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,828 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-15) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,828 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-20) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,830 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-16) REST Request - [HTTP METHOD: GET] [PATH INFO: /favoritepvmodule/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,830 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-21) REST Request - [HTTP METHOD: GET] [PATH INFO: /favoriteinverter/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:13,832 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-16) SELECT e FROM FavoritePVModule e WHERE e.businessAccountId = :businessAccountId ORDER BY e.manufacturer ASC 2018-06-03 16:26:13,832 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-21) SELECT e FROM FavoriteInverter e WHERE e.businessAccountId = :businessAccountId ORDER BY e.manufacturer ASC 2018-06-03 16:26:13,840 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-16) SELECT COUNT(e.id) FROM FavoritePVModule e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:26:13,840 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-21) SELECT COUNT(e.id) FROM FavoriteInverter e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:26:13,885 INFO [com.pvstream.pilot.api.presentation.services.InverterResource] (default task-13) Received request for Inverter search 2018-06-03 16:26:13,887 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-20) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:13,948 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-20) SELECT COUNT(e.pvModuleId) FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:13,985 INFO [com.pvstream.pilot.api.presentation.services.InverterResource] (default task-13) Inverter search - ok 2018-06-03 16:26:14,045 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-14) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:14,102 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-14) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:14,153 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-14) SELECT COUNT(e.inverterId) FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:14,925 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-22) REST Request - [HTTP METHOD: POST] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:14,926 INFO [com.pvstream.pilot.api.core.bl.workflow.businessmodel.UpdateBusinessModelWorkflowImpl] (default task-22) Updating Business model properties 2018-06-03 16:26:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:26:15,018 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:26:17,658 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-23) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:17,658 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-24) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:17,779 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-25) REST Request - [HTTP METHOD: GET] [PATH INFO: /user] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:19,544 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-27) REST Request - [HTTP METHOD: GET] [PATH INFO: /projectInfo/last/5/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:19,545 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-27) SELECT e FROM Project e LEFT JOIN FETCH e.createdBy u WHERE e.businessAccountId = :businessAccountId ORDER BY e.modifiedOn DESC 2018-06-03 16:26:19,556 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-26) REST Request - [HTTP METHOD: GET] [PATH INFO: /projectInfo/list/1/10/modifiedOn/DESC/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:19,556 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-26) SELECT e FROM Project e LEFT JOIN FETCH e.createdBy u WHERE e.businessAccountId = :businessAccountId ORDER BY e.modifiedOn DESC 2018-06-03 16:26:19,559 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-27) SELECT count(e.id) FROM Project e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:26:19,571 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-26) SELECT count(e.id) FROM Project e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:26:20,152 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-28) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:20,152 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-29) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:20,649 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-30) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:20,655 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-31) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:20,676 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-32) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:20,711 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-31) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:20,743 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-32) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:21,475 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-33) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33987/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:21,477 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-34) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:21,477 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-35) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:21,478 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-34) >>> Received request to shadow pies for entire project 2018-06-03 16:26:21,538 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-33) ==> Calling PVWATTS API - Query weather data: lat=56.66&lon=23.71&radius=300&all=1 2018-06-03 16:26:21,538 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-33) PVWatts weather query request URL: https://developer.nrel.gov/api/solar/data_query/v1.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&lat=56.66&lon=23.71&radius=300&all=1 2018-06-03 16:26:21,803 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-36) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/LV] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:21,806 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-37) REST Request - [HTTP METHOD: GET] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:22,002 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-37) ==> Calling PVWATTS API - Query weather data: lat=56.66&lon=23.71&radius=300&all=1 2018-06-03 16:26:22,004 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-37) PVWatts weather query request URL: https://developer.nrel.gov/api/solar/data_query/v1.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&lat=56.66&lon=23.71&radius=300&all=1 2018-06-03 16:26:22,311 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-38) REST Request - [HTTP METHOD: POST] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:22,513 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-38) ==> Calling PVWATTS API - Query weather data: lat=56.66&lon=23.71&radius=300&all=1 2018-06-03 16:26:22,514 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-38) PVWatts weather query request URL: https://developer.nrel.gov/api/solar/data_query/v1.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&lat=56.66&lon=23.71&radius=300&all=1 2018-06-03 16:26:22,865 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-37) PVWatts weather query status code: OK (200) 2018-06-03 16:26:22,866 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-37) ==> Closes weather station: null 2018-06-03 16:26:22,866 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-37) PVWatts simulation service request URL: https://developer.nrel.gov/api/pvwatts/v5.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&system_capacity=1&module_type=0&losses=5&array_type=0&tilt=0.00000&azimuth=53.7500&file_id=2-266290-tm3&timeframe=hourly&dc_ac_ratio=1.100000&gcr=1&inv_eff=96&roof_face_id=1&roof_face_area=100.000 2018-06-03 16:26:22,921 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-33) PVWatts weather query status code: OK (200) 2018-06-03 16:26:22,922 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-33) ==> Closes weather station: null 2018-06-03 16:26:22,922 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-33) PVWatts simulation service request URL: https://developer.nrel.gov/api/pvwatts/v5.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&system_capacity=1&module_type=0&losses=5&array_type=0&tilt=0.00000&azimuth=53.7500&file_id=2-266290-tm3&timeframe=hourly&dc_ac_ratio=1.100000&gcr=1&inv_eff=96&roof_face_id=1&roof_face_area=100.000 2018-06-03 16:26:23,365 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-38) PVWatts weather query status code: OK (200) 2018-06-03 16:26:23,366 INFO [com.pvstream.pilot.api.core.bl.appservice.weatherdata.PVWattsWeatherDataService] (default task-38) ==> Closes weather station: null 2018-06-03 16:26:23,366 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-38) PVWatts simulation service request URL: https://developer.nrel.gov/api/pvwatts/v5.json?api_key=o3hUvnROE4kaiuxdeTj8LbJ58cFVTmwufy1u4VWI&system_capacity=1&module_type=0&losses=5&array_type=0&tilt=0.00000&azimuth=53.7500&file_id=2-266290-tm3&timeframe=hourly&dc_ac_ratio=1.100000&gcr=1&inv_eff=96&roof_face_id=1&roof_face_area=100.000 2018-06-03 16:26:24,308 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-37) PVWatts simulation service status code: OK (200) 2018-06-03 16:26:24,343 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-33) PVWatts simulation service status code: OK (200) 2018-06-03 16:26:24,689 INFO [com.pvstream.pilot.api.core.bl.appservice.irradiance.IrradianceAppServiceImpl] (default task-37) Simulation status code: OK (200) 2018-06-03 16:26:24,728 INFO [com.pvstream.pilot.api.core.bl.appservice.irradiance.IrradianceAppServiceImpl] (default task-33) Simulation status code: OK (200) 2018-06-03 16:26:24,781 ERROR [com.pvstream.pilot.api.core.bl.workflow.Proposal.GetProposalWorkflowImpl] (default task-37) Validation failed for classes [com.pvstream.pilot.api.model.entity.Proposal] during persist time for groups [javax.validation.groups.Default, ] List of constraint violations:[ ConstraintViolationImpl{interpolatedMessage='may not be null', propertyPath=postSolarEnergyBill, rootBeanClass=class com.pvstream.pilot.api.model.entity.Proposal, messageTemplate='{javax.validation.constraints.NotNull.message}'} ]: com.pvstream.pilot.api.model.exception.ValidationException: Validation failed for classes [com.pvstream.pilot.api.model.entity.Proposal] during persist time for groups [javax.validation.groups.Default, ] List of constraint violations:[ ConstraintViolationImpl{interpolatedMessage='may not be null', propertyPath=postSolarEnergyBill, rootBeanClass=class com.pvstream.pilot.api.model.entity.Proposal, messageTemplate='{javax.validation.constraints.NotNull.message}'} ] at com.pvstream.pilot.api.core.dal.repository.RepositoryBase.save(RepositoryBase.java:79) at com.pvstream.pilot.api.core.bl.workflow.Roof.GetRoofFaceIrradianceWorkflowImpl.getRoofFaceIrradiance(GetRoofFaceIrradianceWorkflowImpl.java:84) at com.pvstream.pilot.api.core.bl.workflow.Proposal.GetProposalWorkflowImpl.getProposal(GetProposalWorkflowImpl.java:237) at com.pvstream.pilot.api.core.bl.workflow.Proposal.GetProposalWorkflowImpl.getProposal(GetProposalWorkflowImpl.java:161) at com.pvstream.pilot.api.presentation.services.proposal.ProposalResource.getProposal(ProposalResource.java:46) at com.pvstream.pilot.api.presentation.services.proposal.ProposalResource$Proxy$_$$_WeldClientProxy.getProposal(Unknown Source) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) at java.lang.reflect.Method.invoke(Unknown Source) at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:139) at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTarget(ResourceMethodInvoker.java:295) at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:249) at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:236) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:395) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:202) at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:221) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51) at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) at io.undertow.servlet.handlers.ServletHandler.handleRequest(ServletHandler.java:85) at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:129) at com.pvstream.pilot.api.presentation.services.SessionTimeoutCookieFilter.doFilter(SessionTimeoutCookieFilter.java:37) at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:60) at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) at com.pvstream.pilot.api.presentation.services.ResponseHeaderFilter.doFilter(ResponseHeaderFilter.java:125) at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:60) at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) at com.pvstream.pilot.api.presentation.services.RequestFilter.doFilter(RequestFilter.java:58) at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:60) at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) at org.apache.shiro.web.servlet.ProxiedFilterChain.doFilter(ProxiedFilterChain.java:61) at org.apache.shiro.web.servlet.AdviceFilter.executeChain(AdviceFilter.java:108) at org.apache.shiro.web.servlet.AdviceFilter.doFilterInternal(AdviceFilter.java:137) at org.apache.shiro.web.servlet.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:125) at org.apache.shiro.web.servlet.ProxiedFilterChain.doFilter(ProxiedFilterChain.java:66) at org.apache.shiro.web.servlet.AbstractShiroFilter.executeChain(AbstractShiroFilter.java:449) at org.apache.shiro.web.servlet.AbstractShiroFilter$1.call(AbstractShiroFilter.java:365) at org.apache.shiro.subject.support.SubjectCallable.doCall(SubjectCallable.java:90) at org.apache.shiro.subject.support.SubjectCallable.call(SubjectCallable.java:83) at org.apache.shiro.subject.support.DelegatingSubject.execute(DelegatingSubject.java:383) at org.apache.shiro.web.servlet.AbstractShiroFilter.doFilterInternal(AbstractShiroFilter.java:362) at org.apache.shiro.web.servlet.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:125) at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:60) at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) at io.undertow.servlet.handlers.FilterHandler.handleRequest(FilterHandler.java:84) at io.undertow.servlet.handlers.security.ServletSecurityRoleHandler.handleRequest(ServletSecurityRoleHandler.java:62) at io.undertow.servlet.handlers.ServletDispatchingHandler.handleRequest(ServletDispatchingHandler.java:36) at org.wildfly.extension.undertow.security.SecurityContextAssociationHandler.handleRequest(SecurityContextAssociationHandler.java:78) at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) at io.undertow.servlet.handlers.security.SSLInformationAssociationHandler.handleRequest(SSLInformationAssociationHandler.java:131) at io.undertow.servlet.handlers.security.ServletAuthenticationCallHandler.handleRequest(ServletAuthenticationCallHandler.java:57) at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) at io.undertow.security.handlers.AuthenticationConstraintHandler.handleRequest(AuthenticationConstraintHandler.java:51) at io.undertow.security.handlers.AbstractConfidentialityHandler.handleRequest(AbstractConfidentialityHandler.java:46) at io.undertow.servlet.handlers.security.ServletConfidentialityConstraintHandler.handleRequest(ServletConfidentialityConstraintHandler.java:64) at io.undertow.servlet.handlers.security.ServletSecurityConstraintHandler.handleRequest(ServletSecurityConstraintHandler.java:56) at io.undertow.security.handlers.AuthenticationMechanismsHandler.handleRequest(AuthenticationMechanismsHandler.java:60) at io.undertow.servlet.handlers.security.CachedAuthenticatedSessionHandler.handleRequest(CachedAuthenticatedSessionHandler.java:77) at io.undertow.security.handlers.NotificationReceiverHandler.handleRequest(NotificationReceiverHandler.java:50) at io.undertow.security.handlers.AbstractSecurityContextAssociationHandler.handleRequest(AbstractSecurityContextAssociationHandler.java:43) at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) at org.wildfly.extension.undertow.security.jacc.JACCContextIdHandler.handleRequest(JACCContextIdHandler.java:61) at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) at io.undertow.servlet.handlers.ServletInitialHandler.handleFirstRequest(ServletInitialHandler.java:284) at io.undertow.servlet.handlers.ServletInitialHandler.dispatchRequest(ServletInitialHandler.java:263) at io.undertow.servlet.handlers.ServletInitialHandler.access$000(ServletInitialHandler.java:81) at io.undertow.servlet.handlers.ServletInitialHandler$1.handleRequest(ServletInitialHandler.java:174) at io.undertow.server.Connectors.executeRootHandler(Connectors.java:202) at io.undertow.server.HttpServerExchange$1.run(HttpServerExchange.java:793) at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) at java.lang.Thread.run(Unknown Source) Caused by: javax.validation.ConstraintViolationException: Validation failed for classes [com.pvstream.pilot.api.model.entity.Proposal] during persist time for groups [javax.validation.groups.Default, ] List of constraint violations:[ ConstraintViolationImpl{interpolatedMessage='may not be null', propertyPath=postSolarEnergyBill, rootBeanClass=class com.pvstream.pilot.api.model.entity.Proposal, messageTemplate='{javax.validation.constraints.NotNull.message}'} ] at org.hibernate.cfg.beanvalidation.BeanValidationEventListener.validate(BeanValidationEventListener.java:138) at org.hibernate.cfg.beanvalidation.BeanValidationEventListener.onPreInsert(BeanValidationEventListener.java:78) at org.hibernate.action.internal.EntityIdentityInsertAction.preInsert(EntityIdentityInsertAction.java:197) at org.hibernate.action.internal.EntityIdentityInsertAction.execute(EntityIdentityInsertAction.java:75) at org.hibernate.engine.spi.ActionQueue.execute(ActionQueue.java:597) at org.hibernate.engine.spi.ActionQueue.addResolvedEntityInsertAction(ActionQueue.java:232) at org.hibernate.engine.spi.ActionQueue.addInsertAction(ActionQueue.java:213) at org.hibernate.engine.spi.ActionQueue.addAction(ActionQueue.java:256) at org.hibernate.event.internal.AbstractSaveEventListener.addInsertAction(AbstractSaveEventListener.java:317) at org.hibernate.event.internal.AbstractSaveEventListener.performSaveOrReplicate(AbstractSaveEventListener.java:272) at org.hibernate.event.internal.AbstractSaveEventListener.performSave(AbstractSaveEventListener.java:178) at org.hibernate.event.internal.AbstractSaveEventListener.saveWithGeneratedId(AbstractSaveEventListener.java:109) at org.hibernate.jpa.event.internal.core.JpaPersistEventListener.saveWithGeneratedId(JpaPersistEventListener.java:67) at org.hibernate.event.internal.DefaultPersistEventListener.entityIsTransient(DefaultPersistEventListener.java:189) at org.hibernate.event.internal.DefaultPersistEventListener.onPersist(DefaultPersistEventListener.java:132) at org.hibernate.internal.SessionImpl.firePersistOnFlush(SessionImpl.java:802) at org.hibernate.internal.SessionImpl.persistOnFlush(SessionImpl.java:795) at org.hibernate.engine.spi.CascadingActions$8.cascade(CascadingActions.java:340) at org.hibernate.engine.internal.Cascade.cascadeToOne(Cascade.java:398) at org.hibernate.engine.internal.Cascade.cascadeAssociation(Cascade.java:323) at org.hibernate.engine.internal.Cascade.cascadeProperty(Cascade.java:162) at org.hibernate.engine.internal.Cascade.cascade(Cascade.java:111) at org.hibernate.event.internal.AbstractFlushingEventListener.cascadeOnFlush(AbstractFlushingEventListener.java:150) at org.hibernate.event.internal.AbstractFlushingEventListener.prepareEntityFlushes(AbstractFlushingEventListener.java:141) at org.hibernate.event.internal.AbstractFlushingEventListener.flushEverythingToExecutions(AbstractFlushingEventListener.java:74) at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:38) at org.hibernate.internal.SessionImpl.flush(SessionImpl.java:1282) at org.hibernate.jpa.spi.AbstractEntityManagerImpl.flush(AbstractEntityManagerImpl.java:1300) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) at java.lang.reflect.Method.invoke(Unknown Source) at org.jboss.weld.bean.proxy.AbstractBeanInstance.invoke(AbstractBeanInstance.java:38) at org.jboss.weld.bean.proxy.ProxyMethodHandler.invoke(ProxyMethodHandler.java:100) at org.jboss.weld.proxies.EntityManager$1694547879$Proxy$_$$_WeldClientProxy.flush(Unknown Source) at com.pvstream.pilot.api.core.dal.repository.RepositoryBase.save(RepositoryBase.java:76) ... 73 more 2018-06-03 16:26:24,786 ERROR [com.pvstream.pilot.api.presentation.services.proposal.ProposalResource] (default task-37) Error retrieving proposal 2018-06-03 16:26:24,787 ERROR [org.jboss.as.txn] (default task-37) WFLYTX0003: APPLICATION ERROR: transaction still active in request with status 1 2018-06-03 16:26:24,902 INFO [com.pvstream.pilot.api.core.bl.serviceagents.RESTServiceAgentBase] (default task-38) PVWatts simulation service status code: OK (200) 2018-06-03 16:26:25,287 INFO [com.pvstream.pilot.api.core.bl.appservice.irradiance.IrradianceAppServiceImpl] (default task-38) Simulation status code: OK (200) 2018-06-03 16:26:25,342 ERROR [com.pvstream.pilot.api.core.bl.workflow.Proposal.GetProposalWorkflowImpl] (default task-38) Validation failed for classes [com.pvstream.pilot.api.model.entity.Proposal] during persist time for groups [javax.validation.groups.Default, ] List of constraint violations:[ ConstraintViolationImpl{interpolatedMessage='may not be null', propertyPath=postSolarEnergyBill, rootBeanClass=class com.pvstream.pilot.api.model.entity.Proposal, messageTemplate='{javax.validation.constraints.NotNull.message}'} ]: com.pvstream.pilot.api.model.exception.ValidationException: Validation failed for classes [com.pvstream.pilot.api.model.entity.Proposal] during persist time for groups [javax.validation.groups.Default, ] List of constraint violations:[ ConstraintViolationImpl{interpolatedMessage='may not be null', propertyPath=postSolarEnergyBill, rootBeanClass=class com.pvstream.pilot.api.model.entity.Proposal, messageTemplate='{javax.validation.constraints.NotNull.message}'} ] at com.pvstream.pilot.api.core.dal.repository.RepositoryBase.save(RepositoryBase.java:79) at com.pvstream.pilot.api.core.bl.workflow.Roof.GetRoofFaceIrradianceWorkflowImpl.getRoofFaceIrradiance(GetRoofFaceIrradianceWorkflowImpl.java:84) at com.pvstream.pilot.api.core.bl.workflow.Proposal.GetProposalWorkflowImpl.getProposal(GetProposalWorkflowImpl.java:237) at com.pvstream.pilot.api.presentation.services.proposal.ProposalResource.getProposal(ProposalResource.java:62) at com.pvstream.pilot.api.presentation.services.proposal.ProposalResource$Proxy$_$$_WeldClientProxy.getProposal(Unknown Source) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) at java.lang.reflect.Method.invoke(Unknown Source) at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:139) at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTarget(ResourceMethodInvoker.java:295) at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:249) at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:236) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:395) at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:202) at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:221) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56) at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51) at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) at io.undertow.servlet.handlers.ServletHandler.handleRequest(ServletHandler.java:85) at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:129) at com.pvstream.pilot.api.presentation.services.SessionTimeoutCookieFilter.doFilter(SessionTimeoutCookieFilter.java:37) at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:60) at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) at com.pvstream.pilot.api.presentation.services.ResponseHeaderFilter.doFilter(ResponseHeaderFilter.java:125) at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:60) at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) at com.pvstream.pilot.api.presentation.services.RequestFilter.doFilter(RequestFilter.java:58) at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:60) at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) at org.apache.shiro.web.servlet.ProxiedFilterChain.doFilter(ProxiedFilterChain.java:61) at org.apache.shiro.web.servlet.AdviceFilter.executeChain(AdviceFilter.java:108) at org.apache.shiro.web.servlet.AdviceFilter.doFilterInternal(AdviceFilter.java:137) at org.apache.shiro.web.servlet.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:125) at org.apache.shiro.web.servlet.ProxiedFilterChain.doFilter(ProxiedFilterChain.java:66) at org.apache.shiro.web.servlet.AbstractShiroFilter.executeChain(AbstractShiroFilter.java:449) at org.apache.shiro.web.servlet.AbstractShiroFilter$1.call(AbstractShiroFilter.java:365) at org.apache.shiro.subject.support.SubjectCallable.doCall(SubjectCallable.java:90) at org.apache.shiro.subject.support.SubjectCallable.call(SubjectCallable.java:83) at org.apache.shiro.subject.support.DelegatingSubject.execute(DelegatingSubject.java:383) at org.apache.shiro.web.servlet.AbstractShiroFilter.doFilterInternal(AbstractShiroFilter.java:362) at org.apache.shiro.web.servlet.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:125) at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:60) at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) at io.undertow.servlet.handlers.FilterHandler.handleRequest(FilterHandler.java:84) at io.undertow.servlet.handlers.security.ServletSecurityRoleHandler.handleRequest(ServletSecurityRoleHandler.java:62) at io.undertow.servlet.handlers.ServletDispatchingHandler.handleRequest(ServletDispatchingHandler.java:36) at org.wildfly.extension.undertow.security.SecurityContextAssociationHandler.handleRequest(SecurityContextAssociationHandler.java:78) at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) at io.undertow.servlet.handlers.security.SSLInformationAssociationHandler.handleRequest(SSLInformationAssociationHandler.java:131) at io.undertow.servlet.handlers.security.ServletAuthenticationCallHandler.handleRequest(ServletAuthenticationCallHandler.java:57) at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) at io.undertow.security.handlers.AuthenticationConstraintHandler.handleRequest(AuthenticationConstraintHandler.java:51) at io.undertow.security.handlers.AbstractConfidentialityHandler.handleRequest(AbstractConfidentialityHandler.java:46) at io.undertow.servlet.handlers.security.ServletConfidentialityConstraintHandler.handleRequest(ServletConfidentialityConstraintHandler.java:64) at io.undertow.servlet.handlers.security.ServletSecurityConstraintHandler.handleRequest(ServletSecurityConstraintHandler.java:56) at io.undertow.security.handlers.AuthenticationMechanismsHandler.handleRequest(AuthenticationMechanismsHandler.java:60) at io.undertow.servlet.handlers.security.CachedAuthenticatedSessionHandler.handleRequest(CachedAuthenticatedSessionHandler.java:77) at io.undertow.security.handlers.NotificationReceiverHandler.handleRequest(NotificationReceiverHandler.java:50) at io.undertow.security.handlers.AbstractSecurityContextAssociationHandler.handleRequest(AbstractSecurityContextAssociationHandler.java:43) at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) at org.wildfly.extension.undertow.security.jacc.JACCContextIdHandler.handleRequest(JACCContextIdHandler.java:61) at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) at io.undertow.servlet.handlers.ServletInitialHandler.handleFirstRequest(ServletInitialHandler.java:284) at io.undertow.servlet.handlers.ServletInitialHandler.dispatchRequest(ServletInitialHandler.java:263) at io.undertow.servlet.handlers.ServletInitialHandler.access$000(ServletInitialHandler.java:81) at io.undertow.servlet.handlers.ServletInitialHandler$1.handleRequest(ServletInitialHandler.java:174) at io.undertow.server.Connectors.executeRootHandler(Connectors.java:202) at io.undertow.server.HttpServerExchange$1.run(HttpServerExchange.java:793) at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) at java.lang.Thread.run(Unknown Source) Caused by: javax.validation.ConstraintViolationException: Validation failed for classes [com.pvstream.pilot.api.model.entity.Proposal] during persist time for groups [javax.validation.groups.Default, ] List of constraint violations:[ ConstraintViolationImpl{interpolatedMessage='may not be null', propertyPath=postSolarEnergyBill, rootBeanClass=class com.pvstream.pilot.api.model.entity.Proposal, messageTemplate='{javax.validation.constraints.NotNull.message}'} ] at org.hibernate.cfg.beanvalidation.BeanValidationEventListener.validate(BeanValidationEventListener.java:138) at org.hibernate.cfg.beanvalidation.BeanValidationEventListener.onPreInsert(BeanValidationEventListener.java:78) at org.hibernate.action.internal.EntityIdentityInsertAction.preInsert(EntityIdentityInsertAction.java:197) at org.hibernate.action.internal.EntityIdentityInsertAction.execute(EntityIdentityInsertAction.java:75) at org.hibernate.engine.spi.ActionQueue.execute(ActionQueue.java:597) at org.hibernate.engine.spi.ActionQueue.addResolvedEntityInsertAction(ActionQueue.java:232) at org.hibernate.engine.spi.ActionQueue.addInsertAction(ActionQueue.java:213) at org.hibernate.engine.spi.ActionQueue.addAction(ActionQueue.java:256) at org.hibernate.event.internal.AbstractSaveEventListener.addInsertAction(AbstractSaveEventListener.java:317) at org.hibernate.event.internal.AbstractSaveEventListener.performSaveOrReplicate(AbstractSaveEventListener.java:272) at org.hibernate.event.internal.AbstractSaveEventListener.performSave(AbstractSaveEventListener.java:178) at org.hibernate.event.internal.AbstractSaveEventListener.saveWithGeneratedId(AbstractSaveEventListener.java:109) at org.hibernate.jpa.event.internal.core.JpaPersistEventListener.saveWithGeneratedId(JpaPersistEventListener.java:67) at org.hibernate.event.internal.DefaultPersistEventListener.entityIsTransient(DefaultPersistEventListener.java:189) at org.hibernate.event.internal.DefaultPersistEventListener.onPersist(DefaultPersistEventListener.java:132) at org.hibernate.internal.SessionImpl.firePersistOnFlush(SessionImpl.java:802) at org.hibernate.internal.SessionImpl.persistOnFlush(SessionImpl.java:795) at org.hibernate.engine.spi.CascadingActions$8.cascade(CascadingActions.java:340) at org.hibernate.engine.internal.Cascade.cascadeToOne(Cascade.java:398) at org.hibernate.engine.internal.Cascade.cascadeAssociation(Cascade.java:323) at org.hibernate.engine.internal.Cascade.cascadeProperty(Cascade.java:162) at org.hibernate.engine.internal.Cascade.cascade(Cascade.java:111) at org.hibernate.event.internal.AbstractFlushingEventListener.cascadeOnFlush(AbstractFlushingEventListener.java:150) at org.hibernate.event.internal.AbstractFlushingEventListener.prepareEntityFlushes(AbstractFlushingEventListener.java:141) at org.hibernate.event.internal.AbstractFlushingEventListener.flushEverythingToExecutions(AbstractFlushingEventListener.java:74) at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:38) at org.hibernate.internal.SessionImpl.flush(SessionImpl.java:1282) at org.hibernate.jpa.spi.AbstractEntityManagerImpl.flush(AbstractEntityManagerImpl.java:1300) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) at java.lang.reflect.Method.invoke(Unknown Source) at org.jboss.weld.bean.proxy.AbstractBeanInstance.invoke(AbstractBeanInstance.java:38) at org.jboss.weld.bean.proxy.ProxyMethodHandler.invoke(ProxyMethodHandler.java:100) at org.jboss.weld.proxies.EntityManager$1694547879$Proxy$_$$_WeldClientProxy.flush(Unknown Source) at com.pvstream.pilot.api.core.dal.repository.RepositoryBase.save(RepositoryBase.java:76) ... 72 more 2018-06-03 16:26:25,345 ERROR [com.pvstream.pilot.api.presentation.services.proposal.ProposalResource] (default task-38) Error recalculating savings for version with id 4843 2018-06-03 16:26:25,346 ERROR [org.jboss.as.txn] (default task-38) WFLYTX0003: APPLICATION ERROR: transaction still active in request with status 1 2018-06-03 16:26:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:26:30,021 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:26:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:26:45,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:26:49,181 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-41) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:49,363 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-42) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:49,365 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-43) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:49,409 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-44) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:49,409 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-45) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:49,628 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-46) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:49,944 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-47) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:49,947 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-48) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:50,008 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-48) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:50,008 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-47) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:26:50,671 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-49) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33987/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:50,673 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-40) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:50,673 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-40) >>> Received request to shadow pies for entire project 2018-06-03 16:26:50,674 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-39) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:50,716 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-50) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/LV] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:51,019 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-51) REST Request - [HTTP METHOD: GET] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:26:51,945 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-52) REST Request - [HTTP METHOD: POST] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:27:00,018 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:27:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:27:15,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:27:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:27:30,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:27:32,800 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-53) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:32,949 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-54) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:32,951 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-55) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:32,994 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-60) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:32,994 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-62) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:33,213 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-59) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:33,534 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-58) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:33,534 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-61) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:33,595 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-61) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:27:33,595 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-58) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:27:34,306 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-63) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33987/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:34,306 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-65) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:34,306 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-64) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:34,306 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-64) >>> Received request to shadow pies for entire project 2018-06-03 16:27:34,342 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-66) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/LV] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:34,646 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-57) REST Request - [HTTP METHOD: GET] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:35,591 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-56) REST Request - [HTTP METHOD: POST] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:27:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:27:45,015 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:28:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:28:00,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:28:00,765 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-67) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:00,767 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-68) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:01,016 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-69) REST Request - [HTTP METHOD: GET] [PATH INFO: /user] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:02,081 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-70) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:02,382 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-71) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:02,733 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-72) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:02,733 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-73) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:02,735 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-76) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:02,736 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-78) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:02,738 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-80) REST Request - [HTTP METHOD: GET] [PATH INFO: /favoritepvmodule/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:02,739 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-80) SELECT e FROM FavoritePVModule e WHERE e.businessAccountId = :businessAccountId ORDER BY e.manufacturer ASC 2018-06-03 16:28:02,739 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-77) REST Request - [HTTP METHOD: GET] [PATH INFO: /favoriteinverter/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:02,740 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-77) SELECT e FROM FavoriteInverter e WHERE e.businessAccountId = :businessAccountId ORDER BY e.manufacturer ASC 2018-06-03 16:28:02,751 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-80) SELECT COUNT(e.id) FROM FavoritePVModule e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:28:02,788 INFO [com.pvstream.pilot.api.presentation.services.InverterResource] (default task-73) Received request for Inverter search 2018-06-03 16:28:02,789 INFO [com.pvstream.pilot.api.presentation.services.PVModuleResource] (default task-72) Received request for PVModule search 2018-06-03 16:28:02,797 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-78) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:28:02,826 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-77) SELECT COUNT(e.id) FROM FavoriteInverter e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:28:02,857 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-78) SELECT COUNT(e.pvModuleId) FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:28:02,898 INFO [com.pvstream.pilot.api.presentation.services.InverterResource] (default task-73) Inverter search - ok 2018-06-03 16:28:02,957 INFO [com.pvstream.pilot.api.presentation.services.PVModuleResource] (default task-72) PVModule search - ok 2018-06-03 16:28:03,056 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-81) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:03,112 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-81) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:28:03,164 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-81) SELECT COUNT(e.inverterId) FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:28:03,804 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-79) REST Request - [HTTP METHOD: POST] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:03,805 INFO [com.pvstream.pilot.api.core.bl.workflow.businessmodel.UpdateBusinessModelWorkflowImpl] (default task-79) Updating Business model properties 2018-06-03 16:28:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:28:15,017 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:28:15,087 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-82) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization/list] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:15,089 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-83) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:15,337 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-84) REST Request - [HTTP METHOD: GET] [PATH INFO: /user] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:15,656 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-75) REST Request - [HTTP METHOD: GET] [PATH INFO: /projectInfo/last/5/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:15,656 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-75) SELECT e FROM Project e LEFT JOIN FETCH e.createdBy u WHERE e.businessAccountId = :businessAccountId ORDER BY e.modifiedOn DESC 2018-06-03 16:28:15,669 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-75) SELECT count(e.id) FROM Project e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:28:15,974 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-74) REST Request - [HTTP METHOD: GET] [PATH INFO: /projectInfo/list/1/10/modifiedOn/DESC/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:15,975 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-74) SELECT e FROM Project e LEFT JOIN FETCH e.createdBy u WHERE e.businessAccountId = :businessAccountId ORDER BY e.modifiedOn DESC 2018-06-03 16:28:15,984 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-74) SELECT count(e.id) FROM Project e WHERE e.businessAccountId = :businessAccountId 2018-06-03 16:28:17,308 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-85) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:17,610 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-86) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:18,047 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-87) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:18,089 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-88) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:18,089 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-89) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:18,160 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-88) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:28:18,167 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-89) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:28:18,487 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-90) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33987/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:18,788 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-94) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:18,789 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-94) >>> Received request to shadow pies for entire project 2018-06-03 16:28:18,790 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-93) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:18,806 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-95) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/LV] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:18,812 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-96) REST Request - [HTTP METHOD: GET] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:19,545 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-98) REST Request - [HTTP METHOD: POST] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:28:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:28:30,014 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:28:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:28:45,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:29:00,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:29:00,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:29:13,670 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-97) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:13,842 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-99) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:13,843 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-100) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:13,870 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-101) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:13,873 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-92) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:14,190 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-91) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:14,419 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-103) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:14,419 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-102) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:14,491 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-103) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:29:14,491 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-102) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:29:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:29:15,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:29:15,135 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-105) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:15,135 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-104) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33987/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:15,136 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-105) >>> Received request to shadow pies for entire project 2018-06-03 16:29:15,136 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-106) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:15,172 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-107) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/LV] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:15,475 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-111) REST Request - [HTTP METHOD: GET] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:21,529 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-112) REST Request - [HTTP METHOD: POST] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:29:30,019 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:29:31,913 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-113) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:32,073 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-110) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:32,075 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-115) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:32,111 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-114) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:32,111 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-116) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:32,380 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-117) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:32,647 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-118) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:32,651 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-109) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:32,711 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-118) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:29:32,718 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-109) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:29:33,360 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-108) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33987/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:33,360 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-119) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:33,360 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-119) >>> Received request to shadow pies for entire project 2018-06-03 16:29:33,362 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-120) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:33,398 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-121) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/LV] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:33,700 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-123) REST Request - [HTTP METHOD: GET] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:29:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:29:45,005 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:30:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:30:00,012 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:30:15,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:30:15,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:30:29,322 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-122) REST Request - [HTTP METHOD: POST] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:30:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:30:30,012 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:30:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer start ... 2018-06-03 16:30:45,020 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 9) Email periodic timer end... 2018-06-03 16:31:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer start ... 2018-06-03 16:31:00,006 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 10) Email periodic timer end... 2018-06-03 16:31:00,761 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-124) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:00,923 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-128) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:00,925 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-127) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:00,955 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-132) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:00,955 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-129) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:01,488 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-131) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:01,491 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-133) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:01,491 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-130) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:01,553 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-130) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:31:01,553 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-133) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:31:02,239 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-134) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:02,239 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-135) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33987/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:02,241 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-134) >>> Received request to shadow pies for entire project 2018-06-03 16:31:02,242 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-126) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:02,584 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-125) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/LV] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:02,585 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-136) REST Request - [HTTP METHOD: GET] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:03,424 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-137) REST Request - [HTTP METHOD: POST] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer start ... 2018-06-03 16:31:15,014 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 1) Email periodic timer end... 2018-06-03 16:31:18,918 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-138) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:18,975 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-138) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:31:27,423 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-139) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:27,482 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-139) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:31:30,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer start ... 2018-06-03 16:31:30,010 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 2) Email periodic timer end... 2018-06-03 16:31:45,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer start ... 2018-06-03 16:31:45,007 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 3) Email periodic timer end... 2018-06-03 16:31:58,980 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-140) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:59,136 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-141) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:59,136 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-145) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:59,295 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-146) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:59,295 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-144) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:59,597 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-147) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:59,921 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-148) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:59,924 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-149) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:31:59,984 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-149) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:31:59,984 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-148) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:32:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer start ... 2018-06-03 16:32:00,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 4) Email periodic timer end... 2018-06-03 16:32:00,718 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-150) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33987/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:00,718 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-151) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:00,718 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-151) >>> Received request to shadow pies for entire project 2018-06-03 16:32:00,719 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-152) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:00,755 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-143) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/LV] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:01,060 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-142) REST Request - [HTTP METHOD: GET] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:02,023 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-153) REST Request - [HTTP METHOD: POST] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:15,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer start ... 2018-06-03 16:32:15,024 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 5) Email periodic timer end... 2018-06-03 16:32:30,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer start ... 2018-06-03 16:32:30,009 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 6) Email periodic timer end... 2018-06-03 16:32:45,000 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer start ... 2018-06-03 16:32:45,013 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 7) Email periodic timer end... 2018-06-03 16:32:48,886 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-154) REST Request - [HTTP METHOD: GET] [PATH INFO: /auth/isSessionActive] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:49,038 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-155) REST Request - [HTTP METHOD: GET] [PATH INFO: /currencycode] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:49,041 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-156) REST Request - [HTTP METHOD: GET] [PATH INFO: /localization] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:49,075 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-157) REST Request - [HTTP METHOD: GET] [PATH INFO: /businessmodel] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:49,075 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-158) REST Request - [HTTP METHOD: GET] [PATH INFO: /user/settings] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:49,288 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-162) REST Request - [HTTP METHOD: GET] [PATH INFO: /project/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:49,605 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-161) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/pvmodule/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:49,608 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-165) REST Request - [HTTP METHOD: GET] [PATH INFO: /reference/inverter/list/append/] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:49,664 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-161) SELECT e FROM PVModule e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalModuleId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:32:49,674 INFO [com.pvstream.pilot.api.core.dal.util.QueryHelper] (default task-165) SELECT e FROM Inverter e join e.manufacturer WHERE e.enabled = true AND e.active = true AND e.availableForSimulation = true AND e.originalInverterId IS NULL AND e.enteredBy IS NULL ORDER BY e.manufacturer.fullName ASC 2018-06-03 16:32:50,378 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-166) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/yield/33987/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:50,378 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-163) REST Request - [HTTP METHOD: GET] [PATH INFO: /roof/shadowpie/4169] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:50,379 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-164) REST Request - [HTTP METHOD: GET] [PATH INFO: /annotations/version/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:50,379 INFO [com.pvstream.pilot.api.presentation.services.Roof.RoofResource] (default task-163) >>> Received request to shadow pies for entire project 2018-06-03 16:32:50,726 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-167) REST Request - [HTTP METHOD: GET] [PATH INFO: /energyusage/default/rate/LV] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:50,729 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-168) REST Request - [HTTP METHOD: GET] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:32:51,725 INFO [com.pvstream.pilot.api.presentation.services.RequestFilter] (default task-169) REST Request - [HTTP METHOD: POST] [PATH INFO: /proposal/4843] [REMOTE ADDRESS: 127.0.0.1] 2018-06-03 16:33:00,001 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer start ... 2018-06-03 16:33:00,019 INFO [com.pvstream.pilot.api.core.util.EmailPeriodicTimer] (EJB default - 8) Email periodic timer end... 2018-06-03 16:33:12,904 INFO [org.jboss.as.server] (management-handler-thread - 5) WFLYSRV0211: Suspending server with 0ms timeout. 2018-06-03 16:33:12,908 INFO [org.jboss.as.server] (Thread-2) WFLYSRV0220: Server shutdown has been requested. 2018-06-03 16:33:12,915 INFO [org.wildfly.extension.undertow] (ServerService Thread Pool -- 74) WFLYUT0022: Unregistered web context: / 2018-06-03 16:33:12,915 INFO [org.jboss.as.connector.deployers.jdbc] (MSC service thread 1-1) WFLYJCA0019: Stopped Driver service with driver-name = ROOT.war_com.mysql.cj.jdbc.Driver_6_0 2018-06-03 16:33:12,923 INFO [io.undertow.servlet] (ServerService Thread Pool -- 74) Cleaning up Shiro Environment 2018-06-03 16:33:12,944 INFO [org.jboss.as.clustering.infinispan] (MSC service thread 1-8) WFLYCLINF0003: Stopped jpaRealm.authorizationCache cache from api container 2018-06-03 16:33:12,950 INFO [org.wildfly.extension.undertow] (MSC service thread 1-3) WFLYUT0019: Host default-host stopping 2018-06-03 16:33:12,963 INFO [org.jboss.weld.deployer] (MSC service thread 1-3) WFLYWELD0010: Stopping weld service for deployment ROOT.war