Sabirin
Contributor
Contributor

VMTransport | AesEncryption | decryption failed

Has anyone experienced this problem ?

Is there something i was missing ?

i'm using self-signed certificate for demo in my setup.

the fqdn for HTTP is cdirector.domain.com (10.30.1.60) and for consoleproxy is cproxy.mydomain.com (10.30.1.61)

Thanks in advance

2010-10-14 17:19:22,589 | INFO | Start Level Event Dispatcher | ServiceInitializationTracker | Application startup begins: 10/14/10 5:19 PM |

2010-10-14 17:19:22,695 | DEBUG | Start Level Event Dispatcher | EncryptionManager | EncryptionManager configured with system key. |

2010-10-14 17:19:22,711 | DEBUG | Start Level Event Dispatcher | PassThroughDecrypter | decrypting |

2010-10-14 17:19:24,474 | DEBUG | Start Level Event Dispatcher | EncryptionManager | EncryptionManager has been loaded successfully. |

2010-10-14 17:19:28,433 | INFO | Start Level Event Dispatcher | StartupUtils | Successfully bound network port: 80 on host address: 10.30.1.60 |

2010-10-14 17:19:28,434 | INFO | Start Level Event Dispatcher | StartupUtils | Successfully bound network port: 443 on host address: 10.30.1.60 |

2010-10-14 17:19:28,646 | DEBUG | Start Level Event Dispatcher | JettyStarter | HTTP engine configuration: minThreads: 25, maxThreads: 250 |

2010-10-14 17:19:28,656 | DEBUG | Start Level Event Dispatcher | JettyStarter | HTTP engine configuration: HTTP host address: 10.30.1.60, port: 80, max idle time: 30,000, acceptor threads: 2 |

2010-10-14 17:19:28,667 | INFO | Start Level Event Dispatcher | JettyStarter | Configuring HTTP SSL Connector from certificate store: /opt/vmware/cloud-director/etc/certificates |

2010-10-14 17:19:28,676 | DEBUG | Start Level Event Dispatcher | PassThroughDecrypter | decrypting |

2010-10-14 17:19:28,678 | DEBUG | Start Level Event Dispatcher | PassThroughDecrypter | decrypting |

2010-10-14 17:19:28,679 | DEBUG | Start Level Event Dispatcher | PassThroughDecrypter | decrypting |

2010-10-14 17:19:28,679 | DEBUG | Start Level Event Dispatcher | JettyStarter | HTTP engine configuration: SSL enabled; host address: 10.30.1.60, port: 443, certificate store: /opt/vmware/cloud-director/etc/certificates |

2010-10-14 17:19:28,709 | DEBUG | Start Level Event Dispatcher | JettyStarter | HTTP engine configuration: Request log retention days: 5, timezone: Asia/Jakarta |

2010-10-14 17:19:29,261 | INFO | Start Level Event Dispatcher | JettyStarter | HTTP engine: Started |

VMware Cloud Director 1.0.0.285979 West Indonesia Time

2010-10-14 17:19:30,046 | INFO | - com.vmware.vcloud.common.core.cellApplication.0 | ServiceInitializationTracker | Application Initialization: 9% complete. Subsystem com.vmware.vcloud.common.core started |

2010-10-14 17:19:30,052 | INFO | - com.vmware.vcloud.common.core.cellApplication.0 | StartupUtils | Successfully connected to database: jdbc:oracle:thin:@coracle:1521/vcloud |

2010-10-14 17:19:30,053 | DEBUG | - com.vmware.vcloud.common.core.cellApplication.0 | AbstractCellApplication | Application startup event: Current start level: 40 |

2010-10-14 17:19:30,053 | DEBUG | - com.vmware.vcloud.common.core.cellApplication.0 | AbstractCellApplication | Application startup event: Waiting for module: com.vmware.vcloud.common.core |

2010-10-14 17:19:30,053 | DEBUG | - com.vmware.vcloud.common.core.cellApplication.0 | AbstractCellApplication | Application startup event: Transitioning to start level: 50 |

2010-10-14 17:19:30,053 | DEBUG | - com.vmware.vcloud.common.core.cellApplication.0 | AbstractCellApplication | Application startup event: Waiting for module: com.vmware.vcloud.consoleproxy |

2010-10-14 17:19:31,583 | INFO | SpringOsgiExtenderThread-9 | JaxRsManagerImpl | JAX-RS manager started |

2010-10-14 17:19:31,715 | INFO | SpringOsgiExtenderThread-8 | StartupUtils | Successfully bound network port: 443 on host address: 10.30.1.61 |

2010-10-14 17:19:38,178 | DEBUG | SpringOsgiExtenderThread-7 | ElasticQuartzThreadPool | initialized Quartz-pool-1 (threadCount=128, threadPriority=5) |

2010-10-14 17:19:38,258 | INFO | SpringOsgiExtenderThread-7 | StartupUtils | Successfully bound network port: 61616 on host address: 10.30.1.60 |

2010-10-14 17:19:38,258 | INFO | SpringOsgiExtenderThread-7 | StartupUtils | Successfully bound network port: 61613 on host address: 10.30.1.60 |

2010-10-14 17:19:38,500 | DEBUG | SpringOsgiExtenderThread-11 | EventHandlerTracker | Adding event handler com.vmware.vcloud.common.event.impl.EventPublishingAgent |

2010-10-14 17:19:39,474 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | Starting ActiveMQ Cell DiscoveryAgent broadcaster. Cell UUID: 94c1a44b-f706-498a-ba95-8d268e7dd521 |

2010-10-14 17:19:39,480 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | Starting ActiveMQ Cell DiscoveryAgent listener. Cell UUID: 94c1a44b-f706-498a-ba95-8d268e7dd521 |

*2010-10-14 17:19:40,041 | ERROR | VMTransport | AesEncryption | decryption failed |*

2010-10-14 17:19:40,089 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | Stopping ActiveMQ Cell DiscoveryAgent listener. Cell UUID: 94c1a44b-f706-498a-ba95-8d268e7dd521 |

2010-10-14 17:19:40,089 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | ISOLATING current cell because it has been declared inactive. Cell UUID: 94c1a44b-f706-498a-ba95-8d268e7dd521 |

2010-10-14 17:19:40,090 | DEBUG | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | DISCONNECTED from 0 peer cells |

2010-10-14 17:19:40,090 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | Stopping ActiveMQ Cell DiscoveryAgent broadcaster. Cell UUID: 94c1a44b-f706-498a-ba95-8d268e7dd521 |

2010-10-14 17:19:40,090 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | ISOLATING current cell because it has been declared inactive. Cell UUID: 94c1a44b-f706-498a-ba95-8d268e7dd521 |

2010-10-14 17:19:40,090 | DEBUG | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | DISCONNECTED from 0 peer cells |

2010-10-14 17:19:42,102 | ERROR | SpringOsgiExtenderThread-11 | OsgiBundleXmlApplicationContext | Post refresh error |

org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'hibernateCacheRegions': Cannot create inner bean 'org.springframework.cache.ehcache.EhCacheFactoryBean#6fe2d3cd' of type http://org.springframework.cache.ehcache.EhCacheFactoryBean while setting bean property 'sourceList' with key ; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.cache.ehcache.EhCacheFactoryBean#6fe2d3cd' defined in URL : Cannot resolve reference to bean 'cacheManager' while setting bean property 'cacheManager'; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'cacheManager' defined in URL : Invocation of init method failed; nested exception is net.sf.ehcache.CacheException: Problem creating connections: Error decrypting data.

0 Kudos
2 Replies
admin
Immortal
Immortal

As I pointed out in the other thread, you need to make sure all IPs and hostnames are fully resolvable (forward, back, long, short). At an absolute minimum the settings used in the configure step need to be resolvable. You'll also need to do the same for Oracle DB, vCenter, ESX, vSM, etc.

Do all of the following commands work correctly from the Linux machine you've installed vCD on?

nslookup cdirector

nslookup cdirector.mydomain.com

nslookup 10.30.1.60

nslookup cproxy

nslookup cproxy.mydomain.com

nslookup 10.30.1.61

Additionally, have you checked /etc/hosts to ensure that you don't have cdirector or cproxy mapped to 127.0.0.1 (localhost)? RHEL likes to take whatever hostname you provide in the installer and do that, which often causes problems.

Sabirin
Contributor
Contributor

Dear kmsmith,

Thanks for your comment, i have repair all the dns as you suggest. here is the results

# nslookup cdirector

Server: 10.30.1.95

Address: 10.30.1.95#53

Name: cdirector.xx.com

Address: 10.30.1.60

# nslookup cdirector.xx.com

Server: 10.30.1.95

Address: 10.30.1.95#53

Name: cdirector.xx.com

Address: 10.30.1.60

# nslookup 10.30.1.60

Server: 10.30.1.95

Address: 10.30.1.95#53

60.1.30.10.in-addr.arpa name = cdirector.xx.com.

# nslookup cproxy

Server: 10.30.1.95

Address: 10.30.1.95#53

Name: cproxy.xx.com

Address: 10.30.1.61

# nslookup cproxy.xx.com

Server: 10.30.1.95

Address: 10.30.1.95#53

Name: cproxy.xx.com

Address: 10.30.1.61

# nslookup 10.30.1.61

Server: 10.30.1.95

Address: 10.30.1.95#53

61.1.30.10.in-addr.arpa name = cproxy.xx.com.

#

unfortunately the error about decrypting AES is still there...

i tried to reinstall the vcd, before reinstall i remove the /opt/vmware.

Is there anything else i missed ?

here is the last log.

2010-10-18 10:53:10,727 | DEBUG | Start Level Event Dispatcher | EncryptionManager | EncryptionManager configured with system key. |

2010-10-18 10:53:10,739 | DEBUG | Start Level Event Dispatcher | PassThroughDecrypter | decrypting |

2010-10-18 10:53:12,943 | DEBUG | Start Level Event Dispatcher | EncryptionManager | EncryptionManager has been loaded successfully. |

2010-10-18 10:53:18,541 | INFO | Start Level Event Dispatcher | StartupUtils | Successfully bound network port: 80 on host address: 10.30.1.60 |

2010-10-18 10:53:18,541 | INFO | Start Level Event Dispatcher | StartupUtils | Successfully bound network port: 443 on host address: 10.30.1.60 |

2010-10-18 10:53:19,090 | DEBUG | Start Level Event Dispatcher | JettyStarter | HTTP engine configuration: minThreads: 25, maxThreads: 250 |

2010-10-18 10:53:19,100 | DEBUG | Start Level Event Dispatcher | JettyStarter | HTTP engine configuration: HTTP host address: 10.30.1.60, port: 80, max idle time: 30,000, acceptor threads: 2 |

2010-10-18 10:53:19,100 | INFO | Start Level Event Dispatcher | JettyStarter | Configuring HTTP SSL Connector from certificate store: /opt/vmware/cloud-director/etc/certificates |

2010-10-18 10:53:19,132 | DEBUG | Start Level Event Dispatcher | PassThroughDecrypter | decrypting |

2010-10-18 10:53:19,135 | DEBUG | Start Level Event Dispatcher | PassThroughDecrypter | decrypting |

2010-10-18 10:53:19,135 | DEBUG | Start Level Event Dispatcher | PassThroughDecrypter | decrypting |

2010-10-18 10:53:19,135 | DEBUG | Start Level Event Dispatcher | JettyStarter | HTTP engine configuration: SSL enabled; host address: 10.30.1.60, port: 443, certificate store: /opt/vmware/cloud-director/etc/certificates |

2010-10-18 10:53:19,202 | DEBUG | Start Level Event Dispatcher | JettyStarter | HTTP engine configuration: Request log retention days: 5, timezone: Asia/Jakarta |

2010-10-18 10:53:19,745 | INFO | Start Level Event Dispatcher | JettyStarter | HTTP engine: Started |

VMware Cloud Director 1.0.0.285979 West Indonesia Time

2010-10-18 10:53:21,161 | INFO | - com.vmware.vcloud.common.core.cellApplication.0 | ServiceInitializationTracker | Application Initialization: 9% complete. Subsystem com.vmware.vcloud.common.core started |

2010-10-18 10:53:21,166 | INFO | - com.vmware.vcloud.common.core.cellApplication.0 | StartupUtils | Successfully connected to database: jdbc:oracle:thin:@coracle:1521/vcloud |

2010-10-18 10:53:21,167 | DEBUG | - com.vmware.vcloud.common.core.cellApplication.0 | AbstractCellApplication | Application startup event: Current start level: 40 |

2010-10-18 10:53:21,167 | DEBUG | - com.vmware.vcloud.common.core.cellApplication.0 | AbstractCellApplication | Application startup event: Waiting for module: com.vmware.vcloud.common.core |

2010-10-18 10:53:21,168 | DEBUG | - com.vmware.vcloud.common.core.cellApplication.0 | AbstractCellApplication | Application startup event: Transitioning to start level: 50 |

2010-10-18 10:53:21,168 | DEBUG | - com.vmware.vcloud.common.core.cellApplication.0 | AbstractCellApplication | Application startup event: Waiting for module: com.vmware.vcloud.consoleproxy |

2010-10-18 10:53:23,069 | INFO | SpringOsgiExtenderThread-8 | JaxRsManagerImpl | JAX-RS manager started |

2010-10-18 10:53:23,580 | INFO | SpringOsgiExtenderThread-9 | StartupUtils | Successfully bound network port: 443 on host address: 10.30.1.61 |

2010-10-18 10:53:38,345 | DEBUG | SpringOsgiExtenderThread-7 | ElasticQuartzThreadPool | initialized Quartz-pool-1 (threadCount=128, threadPriority=5) |

2010-10-18 10:53:38,466 | INFO | SpringOsgiExtenderThread-7 | StartupUtils | Successfully bound network port: 61616 on host address: 10.30.1.60 |

2010-10-18 10:53:38,467 | INFO | SpringOsgiExtenderThread-7 | StartupUtils | Successfully bound network port: 61613 on host address: 10.30.1.60 |

2010-10-18 10:53:39,435 | DEBUG | SpringOsgiExtenderThread-11 | EventHandlerTracker | Adding event handler com.vmware.vcloud.common.event.impl.EventPublishingAgent |

2010-10-18 10:53:41,023 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | Starting ActiveMQ Cell DiscoveryAgent broadcaster. Cell UUID: 09ec667f-049e-49d9-ad54-7e1135a51070 |

2010-10-18 10:53:41,108 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | Starting ActiveMQ Cell DiscoveryAgent listener. Cell UUID: 09ec667f-049e-49d9-ad54-7e1135a51070 |

2010-10-18 10:53:41,844 | ERROR | VMTransport | AesEncryption | decryption failed |

2010-10-18 10:53:42,019 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | Stopping ActiveMQ Cell DiscoveryAgent listener. Cell UUID: 09ec667f-049e-49d9-ad54-7e1135a51070 |

2010-10-18 10:53:42,020 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | ISOLATING current cell because it has been declared inactive. Cell UUID: 09ec667f-049e-49d9-ad54-7e1135a51070 |

2010-10-18 10:53:42,021 | DEBUG | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | DISCONNECTED from 0 peer cells |

2010-10-18 10:53:42,021 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | Stopping ActiveMQ Cell DiscoveryAgent broadcaster. Cell UUID: 09ec667f-049e-49d9-ad54-7e1135a51070 |

2010-10-18 10:53:42,021 | INFO | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | ISOLATING current cell because it has been declared inactive. Cell UUID: 09ec667f-049e-49d9-ad54-7e1135a51070 |

2010-10-18 10:53:42,026 | DEBUG | SpringOsgiExtenderThread-11 | CellDiscoveryAgent | DISCONNECTED from 0 peer cells |

2010-10-18 10:53:43,605 | ERROR | SpringOsgiExtenderThread-11 | OsgiBundleXmlApplicationContext | Post refresh error |

xxx

0 Kudos