{"action":"created","issue":{"url":"https://api.github.com/repos/biemond/biemond-orautils/issues/26","repository_url":"https://api.github.com/repos/biemond/biemond-orautils","labels_url":"https://api.github.com/repos/biemond/biemond-orautils/issues/26/labels{/name}","comments_url":"https://api.github.com/repos/biemond/biemond-orautils/issues/26/comments","events_url":"https://api.github.com/repos/biemond/biemond-orautils/issues/26/events","html_url":"https://github.com/biemond/biemond-orautils/issues/26","id":298111125,"number":26,"title":"nodemanagerautostart doesn't work","user":{"login":"danielmenezesbr","id":5949657,"avatar_url":"https://avatars1.githubusercontent.com/u/5949657?v=4","gravatar_id":"","url":"https://api.github.com/users/danielmenezesbr","html_url":"https://github.com/danielmenezesbr","followers_url":"https://api.github.com/users/danielmenezesbr/followers","following_url":"https://api.github.com/users/danielmenezesbr/following{/other_user}","gists_url":"https://api.github.com/users/danielmenezesbr/gists{/gist_id}","starred_url":"https://api.github.com/users/danielmenezesbr/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/danielmenezesbr/subscriptions","organizations_url":"https://api.github.com/users/danielmenezesbr/orgs","repos_url":"https://api.github.com/users/danielmenezesbr/repos","events_url":"https://api.github.com/users/danielmenezesbr/events{/privacy}","received_events_url":"https://api.github.com/users/danielmenezesbr/received_events","type":"User","site_admin":false},"labels":[],"state":"open","locked":false,"assignee":null,"assignees":[],"milestone":null,"comments":7,"created_at":"2018-02-18T19:34:05Z","updated_at":"2018-02-26T20:00:28Z","closed_at":null,"author_association":"NONE","body":"steps to reproduce:\r\n\r\n`git clone https://github.com/biemond/biemond-orawls-vagrant-12.2.1-puppet4`\r\n\r\n`cd biemond-orawls-vagrant-12.2.1-puppet4`\r\n\r\n`vagrant up admin`\r\n\r\n`vagrant ssh admin`\r\n\r\n`sudo -i`\r\n\r\n`ps aux | grep java`\r\n\r\noracle   17940  0.6  2.3 2605604 55500 ?       Sl   18:53   0:28 /usr/java/latest/bin/java -server -Xms32m -Xmx200m -Djdk.tls.ephemeralDHKeySize=2048 -Dcoherence.home=/opt/oracle/middleware12c/wlserver/../coherence -Dbea.home=/opt/oracle/middleware12c/wlserver/.. -Dweblogic.ssl.JSSEEnabled=true -Dweblogic.security.SSL.enableJSSE=true -Dweblogic.security.TrustKeyStore=CustomTrust -Dweblogic.security.CustomTrustKeyStoreFileName=/vagrant/truststore.jks -Dweblogic.security.CustomTrustKeystorePassPhrase=welcome -Daa=1 -Dbb=2 -Dweblogic.RootDirectory=/opt/oracle/wlsdomains/domains/Wls1221 -Djava.system.class.loader=com.oracle.classloader.weblogic.LaunchClassLoader -Djava.security.policy=/opt/oracle/middleware12c/wlserver/server/lib/weblogic.policy -Dweblogic.nodemanager.JavaHome=/usr/java/latest weblogic.**NodeManager** -v\r\n\r\noracle   18047  0.4  2.8 2531456 65980 ?       Sl   18:53   0:23 /usr/java/latest/bin/java -server -Xms32m -Xmx200m -Djdk.tls.ephemeralDHKeySize=2048 -Dcoherence.home=/opt/oracle/middleware12c/wlserver/../coherence -Dbea.home=/opt/oracle/middleware12c/wlserver/.. -Dweblogic.ssl.JSSEEnabled=true -Dweblogic.security.SSL.enableJSSE=true -Dweblogic.RootDirectory=/opt/oracle/wlsdomains/domains/plain_Wls -Djava.system.class.loader=com.oracle.classloader.weblogic.LaunchClassLoader -Djava.security.policy=/opt/oracle/middleware12c/wlserver/server/lib/weblogic.policy -Dweblogic.nodemanager.JavaHome=/usr/java/latest weblogic.NodeManager -v\r\n\r\noracle   18546  5.9 14.7 3691940 347680 ?      Sl   18:56   4:27 /usr/java/latest/bin/java -server -Xms256m -Xmx512m -cp /opt/oracle/middleware12c/wlserver/server/lib/weblogic-launcher.jar -Dlaunch.use.env.classpath=true -Dweblogic.Name=AdminServer -Djava.security.policy=/opt/oracle/middleware12c/wlserver/server/lib/weblogic.policy -Dweblogic.ProductionModeEnabled=true -Dweblogic.system.BootIdentityFile=/opt/oracle/wlsdomains/domains/plain_Wls/servers/AdminServer/security/boot.properties -Dweblogic.nodemanager.ServiceEnabled=true -Dweblogic.nmservice.RotationEnabled=true -XX:PermSize=256m -XX:MaxPermSize=512m -Xms1024m -Xmx1024m -Djava.system.class.loader=com.oracle.classloader.weblogic.LaunchClassLoader -javaagent:/opt/oracle/middleware12c/wlserver/server/lib/debugpatch-agent.jar -da -Dwls.home=/opt/oracle/middleware12c/wlserver/server -Dweblogic.home=/opt/oracle/middleware12c/wlserver/server weblogic.Server\r\n\r\noracle   31725  0.2  1.6 2847896 39488 ?       Sl   19:24   0:06 /usr/java/latest/bin/java -Dderby.system.home=/opt/oracle/wlsdomains/domains/Wls1221/common/db -classpath /opt/oracle/middleware12c/wlserver/common/derby/lib/derby.jar:/opt/oracle/middleware12c/wlserver/common/derby/lib/derbynet.jar:/opt/oracle/middleware12c/wlserver/common/derby/lib/derbytools.jar:/opt/oracle/middleware12c/wlserver/common/derby/lib/derbyclient.jar org.apache.derby.drda.NetworkServerControl start\r\n\r\noracle   31726  7.6 34.1 3680164 802144 ?      Sl   19:24   3:35 /usr/java/latest/bin/java -server -Xms256m -Xmx512m -cp /opt/oracle/middleware12c/wlserver/server/lib/weblogic-launcher.jar -Dlaunch.use.env.classpath=true -Dweblogic.Name=AdminServer -Djava.security.policy=/opt/oracle/middleware12c/wlserver/server/lib/weblogic.policy -Dweblogic.ProductionModeEnabled=true -Dweblogic.system.BootIdentityFile=/opt/oracle/wlsdomains/domains/Wls1221/servers/AdminServer/security/boot.properties -Dweblogic.nodemanager.ServiceEnabled=true -Dweblogic.nmservice.RotationEnabled=true -XX:PermSize=256m -XX:MaxPermSize=512m -Xms1024m -Xmx1024m -Dweblogic.Stdout=/var/log/weblogic/AdminServer.out -Dweblogic.Stderr=/var/log/weblogic/AdminServer_err.out -Djava.system.class.loader=com.oracle.classloader.weblogic.LaunchClassLoader -javaagent:/opt/oracle/middleware12c/wlserver/server/lib/debugpatch-agent.jar -da -Dwls.home=/opt/oracle/middleware12c/wlserver/server -Dweblogic.home=/opt/oracle/middleware12c/wlserver/server weblogic.Server\r\n\r\nroot     32169  0.0  0.0   9048   924 pts/0    S+   20:11   0:00 grep --color=auto java\r\n\r\n`exit`\r\n\r\n`vagrant reload admin`\r\n\r\n`vagrant ssh admin`\r\n\r\n`sudo -i`\r\n\r\n`ps aux | grep java`\r\n\r\nroot     11532  0.0  0.0   9044   664 pts/0    S+   20:15   0:00 grep --color=auto java\r\n\r\n`journalctl -u nodemanager.service`\r\n\r\n-- Logs begin at Sun 2018-02-18 20:14:16 CET, end at Sun 2018-02-18 20:15:58 CET. --\r\nFeb 18 20:14:36 admin.example.com systemd[1]: Started WebLogic nodemanager service.\r\nFeb 18 20:14:36 admin.example.com systemd[1]: Starting WebLogic nodemanager service...\r\nFeb 18 20:14:48 admin.example.com su[3729]: (to oracle) root on none\r\nFeb 18 20:14:49 admin.example.com nodemanager[973]: Starting nodemanager:\r\nFeb 18 20:14:50 admin.example.com nodemanager[973]: NODEMGR_HOME /opt/oracle/middleware12c/wlserver/../oracle_common/common/nodemanager does not exist, creating it..\r\nFeb 18 20:14:50 admin.example.com nodemanager[973]: CLASSPATH=/usr/java/jdk1.8.0_151/lib/tools.jar:/opt/oracle/middleware12c/wlserver/server/lib/weblogic.jar:/opt/oracle/middleware12c/wlserver/../oracle_common/modules/thirdparty/ant-contrib-1.0b3.jar:/opt/oracle/middleware12c/wlserver/modules/features/oracle.wls.common.nodemanager.jar::/opt/oracle/middleware12c/wlserver/..:/opt/oracle/middleware12c/wlserver/modules/features/oracle.wls.common.grizzly.jar\r\nFeb 18 20:14:50 admin.example.com nodemanager[973]: + /usr/java/jdk1.8.0_151/bin/java -server -Xms32m -Xmx200m -Djdk.tls.ephemeralDHKeySize=2048 -Dweblogic.RootDirectory=/opt/oracle/middleware12c/wlserver/../oracle_common/common/nodemanager -Dcoherence.home=/opt/oracle/middleware12c/wlserver/../coherence -Dbea.home=/opt/oracle/middleware12c/wlserver/.. -Dweblogic.ssl.JSSEEnabled=true -Dweblogic.security.SSL.enableJSSE=true -Dweblogic.security.TrustKeyStore=CustomTrust -Dweblogic.security.CustomTrustKeyStoreFileName=/vagrant/truststore.jks -Dweblogic.security.CustomTrustKeystorePassPhrase=welcome -Djava.system.class.loader=com.oracle.classloader.weblogic.LaunchClassLoader -Djava.security.policy=/opt/oracle/middleware12c/wlserver/server/lib/weblogic.policy -Dweblogic.nodemanager.JavaHome=/usr/java/jdk1.8.0_151 weblogic.NodeManager -v\r\nFeb 18 20:15:02 admin.example.com nodemanager[973]: <Feb 18, 2018 8:15:02 PM CET> <INFO> <Loading domains file: /opt/oracle/middleware12c/oracle_common/common/nodemanager/nodemanager.domains>\r\nFeb 18 20:15:02 admin.example.com nodemanager[973]: <Feb 18, 2018 8:15:02 PM CET> <WARNING> <Domains file not found: /opt/oracle/middleware12c/oracle_common/common/nodemanager/nodemanager.domains>\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: <Feb 18, 2018 8:15:04 PM CET> <INFO> <Loading identity key store: FileName=/opt/oracle/middleware12c/oracle_common/common/nodemanager/security/DemoIdentity.jks, Type=jks, PassPhraseUsed=true>\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: <Feb 18, 2018 8:15:04 PM CET> <SEVERE> <Fatal error in NodeManager server>\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: weblogic.nodemanager.common.ConfigException: Identity key store file not found: /opt/oracle/middleware12c/oracle_common/common/nodemanager/security/DemoIdentity.jks\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: at weblogic.nodemanager.server.SSLConfig.loadKeyStoreConfig(SSLConfig.java:225)\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: at weblogic.nodemanager.server.SSLConfig.access$000(SSLConfig.java:33)\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: at weblogic.nodemanager.server.SSLConfig$1.run(SSLConfig.java:118)\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: at java.security.AccessController.doPrivileged(Native Method)\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: at weblogic.nodemanager.server.SSLConfig.<init>(SSLConfig.java:115)\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: at weblogic.nodemanager.server.NMServer.<init>(NMServer.java:169)\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: at weblogic.nodemanager.server.NMServer.getInstance(NMServer.java:134)\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: at weblogic.nodemanager.server.NMServer.main(NMServer.java:589)\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: at weblogic.NodeManager.main(NodeManager.java:31)\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: + status=1\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: + set +x\r\nFeb 18 20:15:04 admin.example.com nodemanager[973]: /home/oracle\r\n\r\n```cat /opt/oracle/middleware12c/oracle_common/common/nodemanager/nodemanager.log```\r\n\r\n<Feb 18, 2018 8:15:02 PM CET> <INFO> <Loading domains file: /opt/oracle/middleware12c/oracle_common/common/nodemanager/nodemanager.domains>\r\n<Feb 18, 2018 8:15:02 PM CET> <WARNING> <Domains file not found: /opt/oracle/middleware12c/oracle_common/common/nodemanager/nodemanager.domains>\r\n<Feb 18, 2018 8:15:04 PM CET> <INFO> <Loading identity key store: FileName=/opt/oracle/middleware12c/oracle_common/common/nodemanager/security/DemoIdentity.jks, Type=jks, PassPhraseUsed=true>\r\n<Feb 18, 2018 8:15:04 PM CET> <SEVERE> <Fatal error in NodeManager server>\r\nweblogic.nodemanager.common.ConfigException: Identity key store file not found: /opt/oracle/middleware12c/oracle_common/common/nodemanager/security/DemoIdentity.jks\r\n        at weblogic.nodemanager.server.SSLConfig.loadKeyStoreConfig(SSLConfig.java:225)\r\n        at weblogic.nodemanager.server.SSLConfig.access$000(SSLConfig.java:33)\r\n        at weblogic.nodemanager.server.SSLConfig$1.run(SSLConfig.java:118)\r\n        at java.security.AccessController.doPrivileged(Native Method)\r\n        at weblogic.nodemanager.server.SSLConfig.<init>(SSLConfig.java:115)\r\n        at weblogic.nodemanager.server.NMServer.<init>(NMServer.java:169)\r\n        at weblogic.nodemanager.server.NMServer.getInstance(NMServer.java:134)\r\n        at weblogic.nodemanager.server.NMServer.main(NMServer.java:589)\r\n        at weblogic.NodeManager.main(NodeManager.java:31)"},"comment":{"url":"https://api.github.com/repos/biemond/biemond-orautils/issues/comments/368630717","html_url":"https://github.com/biemond/biemond-orautils/issues/26#issuecomment-368630717","issue_url":"https://api.github.com/repos/biemond/biemond-orautils/issues/26","id":368630717,"user":{"login":"biemond","id":1085004,"avatar_url":"https://avatars3.githubusercontent.com/u/1085004?v=4","gravatar_id":"","url":"https://api.github.com/users/biemond","html_url":"https://github.com/biemond","followers_url":"https://api.github.com/users/biemond/followers","following_url":"https://api.github.com/users/biemond/following{/other_user}","gists_url":"https://api.github.com/users/biemond/gists{/gist_id}","starred_url":"https://api.github.com/users/biemond/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/biemond/subscriptions","organizations_url":"https://api.github.com/users/biemond/orgs","repos_url":"https://api.github.com/users/biemond/repos","events_url":"https://api.github.com/users/biemond/events{/privacy}","received_events_url":"https://api.github.com/users/biemond/received_events","type":"User","site_admin":false},"created_at":"2018-02-26T20:00:28Z","updated_at":"2018-02-26T20:00:28Z","author_association":"OWNER","body":"it works, I increased the timeout\r\n\r\n```\r\nedwins-mbp:biemond-orawls-vagrant-12.2.1-puppet4 edwinbiemond$ vagrant reload admin\r\n==> admin: Attempting graceful shutdown of VM...\r\n==> admin: Clearing any previously set forwarded ports...\r\n==> admin: Clearing any previously set network interfaces...\r\n==> admin: Preparing network interfaces based on configuration...\r\n    admin: Adapter 1: nat\r\n    admin: Adapter 2: hostonly\r\n==> admin: Forwarding ports...\r\n    admin: 22 (guest) => 2222 (host) (adapter 1)\r\n==> admin: Running 'pre-boot' VM customizations...\r\n==> admin: Booting VM...\r\n==> admin: Waiting for machine to boot. This may take a few minutes...\r\n    admin: SSH address: 127.0.0.1:2222\r\n    admin: SSH username: vagrant\r\n    admin: SSH auth method: private key\r\n==> admin: Machine booted and ready!\r\n==> admin: Checking for guest additions in VM...\r\n==> admin: Setting hostname...\r\n==> admin: Configuring and enabling network interfaces...\r\n    admin: SSH address: 127.0.0.1:2222\r\n    admin: SSH username: vagrant\r\n    admin: SSH auth method: private key\r\n==> admin: Mounting shared folders...\r\n    admin: /vagrant => /Users/edwinbiemond/projects/biemond-orawls-vagrant-12.2.1-puppet4\r\n    admin: /software => /Users/edwinbiemond/projects/biemond-orawls-vagrant-12.2.1-puppet4/software\r\n    admin: /tmp/vagrant-puppet/environments => /Users/edwinbiemond/projects/biemond-orawls-vagrant-12.2.1-puppet4/puppet/environments\r\n    admin: /tmp/vagrant-puppet/manifests-2f329e84676fba04b7e4a879fc63af45 => /Users/edwinbiemond/projects/biemond-orawls-vagrant-12.2.1-puppet4/puppet/environments/development/manifests\r\n==> admin: Machine already provisioned. Run `vagrant provision` or use the `--provision`\r\n==> admin: flag to force provisioning. Provisioners marked to run always will still run.\r\n==> admin: Running provisioner: puppet...\r\n==> admin: Running Puppet with environment development...\r\n==> admin: Info: Loading facts\r\n==> admin: Info: Loading facts\r\n==> admin: Info: Loading facts\r\n==> admin: Info: Loading facts\r\n==> admin: Info: Loading facts\r\n==> admin: Info: Loading facts\r\n==> admin: Warning: The function 'hiera' is deprecated in favor of using 'lookup'. See https://docs.puppet.com/puppet/4.10/reference/deprecated_language.html\r\n==> admin:    (file & line not available)\r\n==> admin: Warning: /vagrant/puppet/hiera.yaml: Use of 'hiera.yaml' version 3 is deprecated. It should be converted to version 5\r\n==> admin:    (in /vagrant/puppet/hiera.yaml)\r\n==> admin: Warning: Defining \"data_provider\": \"hiera\" in metadata.json is deprecated\r\n==> admin:    (in /tmp/vagrant-puppet/environments/development/modules/orawls/metadata.json)\r\n==> admin: Warning: Defining \"data_provider\": \"hiera\" in metadata.json is deprecated\r\n==> admin:    (in /tmp/vagrant-puppet/environments/development/modules/jdk7/metadata.json)\r\n==> admin: Info: orawls::domain_exists: full domain path /opt/oracle/wlsdomains/domains/wls1221\r\n==> admin: Info: orawls::domain_exists: total domains 2\r\n==> admin: Info: orawls::domain_exists: compare /opt/oracle/wlsdomains/domains/wls1221 with /opt/oracle/wlsdomains/domains/wls1221\r\n==> admin: Info: orawls::domain_exists: full domain path /opt/oracle/wlsdomains/domains/plain_wls\r\n==> admin: Info: orawls::domain_exists: total domains 2\r\n==> admin: Info: orawls::domain_exists: compare /opt/oracle/wlsdomains/domains/plain_wls with /opt/oracle/wlsdomains/domains/wls1221\r\n==> admin: Info: orawls::domain_exists: compare /opt/oracle/wlsdomains/domains/plain_wls with /opt/oracle/wlsdomains/domains/plain_wls\r\n==> admin: Notice: Compiled catalog for admin.example.com in environment development in 6.89 seconds\r\n==> admin: caution: filename not matched:  META-INF/MANIFEST.MF\r\n==> admin: Info: Applying configuration version '1519674985'\r\n==> admin: Notice: /Stage[main]/Nodemanager/Orawls::Nodemanager[nodemanager]/Exec[startNodemanager nodemanager]/returns: executed successfully\r\n==> admin: Info: /Stage[main]/Nodemanager/Orawls::Nodemanager[nodemanager]/Exec[startNodemanager nodemanager]: Scheduling refresh of Sleep[wake up nodemanager]\r\n==> admin: Notice: /Stage[main]/Nodemanager/Orawls::Nodemanager[nodemanager]/Sleep[wake up nodemanager]: Triggered 'refresh' from 1 events\r\n==> admin: Notice: /Stage[main]/Nodemanager/Orawls::Nodemanager[nodemanager_plain]/Exec[startNodemanager nodemanager_plain]/returns: executed successfully\r\n==> admin: Info: /Stage[main]/Nodemanager/Orawls::Nodemanager[nodemanager_plain]/Exec[startNodemanager nodemanager_plain]: Scheduling refresh of Sleep[wake up nodemanager_plain]\r\n==> admin: Notice: /Stage[main]/Nodemanager/Orawls::Nodemanager[nodemanager_plain]/Sleep[wake up nodemanager_plain]: Triggered 'refresh' from 1 events\r\n==> admin: Info: Starting the wls daemon for domain default\r\n==> admin: Info: Executing wls-script /tmp/wlstCommonScript.py20180226-8835-zv09lx\r\n==> admin: Info: Executing wls-script /tmp/wlstScript20180226-8835-1igmmqh.py with timeout = 120\r\n==> admin: Info: Connecting to wls on url t3s://10.10.10.10:7002\r\n==> admin: Info: Starting the wls daemon for domain plain\r\n==> admin: Info: Executing wls-script /tmp/wlstCommonScript.py20180226-8835-1wes0dg\r\n==> admin: Info: Executing wls-script /tmp/wlstScript20180226-8835-1igmmqh.py with timeout = 120\r\n==> admin: Info: Connecting to wls on url t3://10.10.10.10:7101\r\n```"}}
{"actor":{"display_login":"biemond"}}