[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]

Re: OO: App status UNKNOWN RHEL6



Hi -

Are you able to preform other actions on the app/gear?

As Clayton said, 109ms is good. It would be worth checking the time on both the broker and the node to see if they differ.

Thanks
-dant



On 11/28/2013 11:42 AM, Clayton Coleman wrote:
109ms is well within the timeout imposed for status calls by default.
  Would recommend throwing a print statement into the
mcollectiveapplicationproxy class to print out the value returned by the
app info call and then restart the broker.  Don't have the source in
front of me right now.

On Nov 28, 2013, at 3:34 AM, Gordan Ristic <gr pcsol be
<mailto:gr pcsol be>> wrote:

Here are the logs:

broker:
user_action.log
RESULT=SUCCESS STATUS=unknown TIMESTAMP=1385562212 DATE=2013-11-27
TIME=15:23:32 ACTION=AUTHENTICATE
REQ_ID=f7ff55394d9b45e34597cd39b989a765
USER_ID=528e157345945b51db000037 LOGIN=fr IP=127.0.0.1 SCOPES=session
Authenticated
RESULT=SUCCESS STATUS=unknown TIMESTAMP=1385562212 DATE=2013-11-27
TIME=15:23:32 ACTION=AUTHENTICATE
REQ_ID=2f080ce26eaa5f9b5101fac7603db4b5
USER_ID=528e157345945b51db000037 LOGIN=fr IP=127.0.0.1 SCOPES=session
Authenticated
RESULT=SUCCESS STATUS=ok TIMESTAMP=1385562212 DATE=2013-11-27
TIME=15:23:32 ACTION=SHOW_APPLICATION
REQ_ID=f7ff55394d9b45e34597cd39b989a765
USER_ID=528e157345945b51db000037 LOGIN=fr
APP_UUID=5295bbf045945bfa0d000035 DOMAIN=frfr Application 'php' found
RESULT=SUCCESS STATUS=ok TIMESTAMP=1385562212 DATE=2013-11-27
TIME=15:23:32 ACTION=LIST_GEAR_GROUP
REQ_ID=2f080ce26eaa5f9b5101fac7603db4b5
USER_ID=528e157345945b51db000037 LOGIN=fr
APP_UUID=5295bbf045945bfa0d000035 DOMAIN=frfr Showing gear groups for
application 'php' with domain 'frfr'
production.log
[INFO ] Started GET
"/broker/rest/application/5295bbf045945bfa0d000035.json?include=cartridges"
for 127.0.0.1 at 2013-11-27 15:25:38 +0100 (pid:1820)
[INFO ] Started GET
"/broker/rest/application/5295bbf045945bfa0d000035/gear_groups.json"
for 127.0.0.1 at 2013-11-27 15:25:38 +0100 (pid:1828)
[INFO ] Processing by ApplicationsController#show as JSON (pid:1820)
[INFO ] Parameters: {"include"=>"cartridges",
"id"=>"5295bbf045945bfa0d000035"} (pid:1820)
[INFO ] Completed 200 OK in 49ms (Views: 11.7ms) (pid:1820)
[INFO ] Processing by GearGroupsController#index as JSON (pid:1828)
[INFO ] Parameters: {"application_id"=>"5295bbf045945bfa0d000035"}
(pid:1828)
[INFO ] Completed 200 OK in 109ms (Views: 1.3ms) (pid:1828)
[INFO ] Started GET "/broker/rest/cartridges.json" for 127.0.0.1 at
2013-11-27 15:25:39 +0100 (pid:1828)
[INFO ] Processing by CartridgesController#index as JSON (pid:1828)
[INFO ] Completed 200 OK in 12ms (Views: 5.8ms) (pid:1828)
console:
production.log
[INFO ] Started GET
"/console/application/5295bbf045945bfa0d000035-php" for 127.0.0.1 at
2013-11-27 15:33:32 +0100 (pid:1875)
[INFO ] Processing by ApplicationsController#show as HTML (pid:1875)
[INFO ] Parameters: {"id"=>"5295bbf045945bfa0d000035-php"} (pid:1875)
[INFO ] Rendered
/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-console-1.16.1/app/views/restarts/_form.html.haml
(5.5ms) (pid:1875)
[INFO ] Rendered
/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-console-1.16.1/app/views/applications/show.html.haml
within layouts/console (83.1ms) (pid:1875)
[INFO ] Rendered
/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-console-1.16.1/app/views/layouts/_head.html.haml
(1.9ms) (pid:1875)
[INFO ] Rendered
/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-console-1.16.1/app/views/layouts/console/_stylesheets.html.haml
(1.0ms) (pid:1875)
[INFO ] Rendered
/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-console-1.16.1/app/views/layouts/console/_header.html.haml
(2.8ms) (pid:1875)
[INFO ] Rendered
/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-console-1.16.1/app/views/layouts/_footer.html.haml
(0.9ms) (pid:1875)
[INFO ] Rendered
/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-console-1.16.1/app/views/layouts/console/_javascripts.html.haml
(0.7ms) (pid:1875)
[INFO ] Rendered
/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-console-1.16.1/app/views/shared/_tracking.html.haml
(0.1ms) (pid:1875)
[INFO ] Completed 200 OK in 239ms (Views: 95.8ms) (pid:1875)

Nothing in error.log files


Le 27 nov. 2013 à 17:54, Clayton Coleman <ccoleman redhat com
<mailto:ccoleman redhat com>> a écrit :

Look in the broker log for that time window.  The mcollective
response looks correct to me.

----- Original Message -----
Hi Clayton,

Thank you for the update.

Here are the logs for Mcollective.

Broker, mcollective-client.log:
D, [2013-11-27T15:20:24.989324 #1820] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin connector_plugin with class
MCollective::Connector::Activemq
D, [2013-11-27T15:20:24.992941 #1820] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:20:24.993462 #1820] DEBUG -- : activemq.rb:149:in
`connect'
Already connection, not re-initializing connection
D, [2013-11-27T15:20:24.994017 #1820] DEBUG -- : cache.rb:101:in
`read' Cache
expired on 'ddl' key 'agent/openshift'
D, [2013-11-27T15:20:24.994577 #1820] DEBUG -- : base.rb:93:in `block in
findddlfile' Found openshift ddl at
/opt/rh/ruby193/root/usr/libexec/mcollective/mcollective/agent/openshift.ddl
D, [2013-11-27T15:20:25.001096 #1820] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:20:25.001393 #1820] DEBUG -- : psk.rb:98:in `callerid'
Setting callerid to uid=48 based on callertype=uid
D, [2013-11-27T15:20:25.001766 #1820] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:20:25.003009 #1820] DEBUG -- : client.rb:146:in `req'
Publishing request to agent openshift with timeout 180
D, [2013-11-27T15:20:25.003585 #1820] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:20:25.006017 #1820] DEBUG -- : base.rb:178:in
`create_request' Encoding a request for agent 'openshift' in collective
mcollective with request id cbc7f4eafd94508fb68d4284daa438dd
D, [2013-11-27T15:20:25.006290 #1820] DEBUG -- : psk.rb:98:in `callerid'
Setting callerid to uid=48 based on callertype=uid
D, [2013-11-27T15:20:25.006738 #1820] DEBUG -- : client.rb:51:in
`sendreq'
Sending request cbc7f4eafd94508fb68d4284daa438dd to the openshift
agent with
ttl 60 in collective mcollective
D, [2013-11-27T15:20:25.007033 #1820] DEBUG -- : client.rb:63:in
`subscribe'
Subscribing to reply target for agent openshift
D, [2013-11-27T15:20:25.007342 #1820] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin connector_plugin with class
MCollective::Connector::Activemq
D, [2013-11-27T15:20:25.009674 #1820] DEBUG -- : activemq.rb:277:in
`subscribe' Subscribing to
/queue/mcollective.reply.broker.domain.test.com_1820 with headers {}
D, [2013-11-27T15:20:25.025851 #1820] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin connector_plugin with class
MCollective::Connector::Activemq
D, [2013-11-27T15:20:25.026161 #1820] DEBUG -- : activemq.rb:266:in
`publish'
Sending a broadcast message to ActiveMQ target
'/topic/mcollective.openshift.agent' with headers
'{"reply-to"=>"/queue/mcollective.reply.broker.domain.test.com_1820"}'
D, [2013-11-27T15:20:25.026586 #1820] DEBUG -- : activemq.rb:233:in
`receive'
Waiting for a message from ActiveMQ
D, [2013-11-27T15:20:25.095520 #1820] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:20:25.095997 #1820] DEBUG -- : runnerstats.rb:38:in
`validated' Incrementing validated stat
D, [2013-11-27T15:20:25.096564 #1820] DEBUG -- : client.rb:73:in
`unsubscribe' Unsubscribing reply target for openshift
D, [2013-11-27T15:20:25.097073 #1820] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin connector_plugin with class
MCollective::Connector::Activemq
D, [2013-11-27T15:20:25.097420 #1820] DEBUG -- : activemq.rb:289:in
`unsubscribe' Unsubscribing from
/queue/mcollective.reply.broker.domain.test.com_1820
D, [2013-11-27T15:20:25.098195 #1820] DEBUG -- : client.rb:33:in
`disconnect'
Disconnecting from the middleware
D, [2013-11-27T15:20:25.098542 #1820] DEBUG -- : activemq.rb:308:in
`disconnect' Disconnecting from ActiveMQ
Node, mcollective.log:
D, [2013-11-27T15:38:39.409293 #1037] DEBUG -- : runnerstats.rb:49:in
`received' Incrementing total stat
D, [2013-11-27T15:38:39.409633 #1037] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:38:39.409890 #1037] DEBUG -- : runnerstats.rb:38:in
`validated' Incrementing validated stat
D, [2013-11-27T15:38:39.410105 #1037] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:38:39.410284 #1037] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:38:39.410553 #1037] DEBUG -- : base.rb:117:in
`block (2
levels) in validate_filter?' Passing based on agent openshift
D, [2013-11-27T15:38:39.410703 #1037] DEBUG -- : base.rb:142:in
`block in
validate_filter?' Passing based on identity
D, [2013-11-27T15:38:39.410849 #1037] DEBUG -- : base.rb:153:in
`validate_filter?' Message passed the filter checks
D, [2013-11-27T15:38:39.410968 #1037] DEBUG -- : runnerstats.rb:26:in
`passed' Incrementing passed stat
D, [2013-11-27T15:38:39.411131 #1037] DEBUG -- : runner.rb:80:in
`agentmsg'
Handling message for agent 'openshift' on collective 'mcollective'
D, [2013-11-27T15:38:39.411245 #1037] DEBUG -- : agents.rb:119:in
`dispatch'
Dispatching a message to agent openshift
D, [2013-11-27T15:38:39.411623 #1037] DEBUG -- : activemq.rb:233:in
`receive'
Waiting for a message from ActiveMQ
D, [2013-11-27T15:38:39.411829 #1037] DEBUG -- :
pluginmanager.rb:88:in `[]'
Returning new plugin openshift_agent with class
MCollective::Agent::Openshift
D, [2013-11-27T15:38:39.412180 #1037] DEBUG -- : cache.rb:101:in
`read' Cache
expired on 'ddl' key 'agent/openshift'
D, [2013-11-27T15:38:39.412827 #1037] DEBUG -- : base.rb:93:in `block in
findddlfile' Found openshift ddl at
/opt/rh/ruby193/root/usr/libexec/mcollective/mcollective/agent/openshift.ddl
D, [2013-11-27T15:38:39.415406 #1037] DEBUG -- : openshift.rb:47:in
`before_processing_hook' Changing working directory to /tmp
I, [2013-11-27T15:38:39.417324 #1037]  INFO -- : openshift.rb:200:in
`execute_parallel_action' execute_parallel_action call / action:
execute_parallel, agent=openshift, data={"n1.domain.test.com
<http://n1.domain.test.com>"=>
 [{:tag=>"",
   :gear=>"5295bbf045945bfa0d000035",
   :job=>
    {:cartridge=>"openshift-origin-node",
     :action=>"app-state-show",
     :args=>
      {"--with-app-uuid"=>"5295bbf045945bfa0d000035",
       "--with-app-name"=>"php",
       "--with-container-uuid"=>"5295bbf045945bfa0d000035",
       "--with-container-name"=>"php",
       "--with-namespace"=>"frfr",
       "--with-request-id"=>"13da5f7e7bc7415c3174d0cb23b49265"}},
   :result_stdout=>"",
   :result_stderr=>"",
   :result_exit_code=>""}],
:process_results=>true}

I, [2013-11-27T15:38:39.417720 #1037]  INFO -- : openshift.rb:170:in
`execute_action' Executing action [app-state-show] using method
oo_app_state_show with args
[{"--with-app-uuid"=>"5295bbf045945bfa0d000035",
"--with-app-name"=>"php",
"--with-container-uuid"=>"5295bbf045945bfa0d000035",
"--with-container-name"=>"php", "--with-namespace"=>"frfr",
"--with-request-id"=>"13da5f7e7bc7415c3174d0cb23b49265"}]
I, [2013-11-27T15:38:39.418623 #1037]  INFO -- : openshift.rb:185:in
`execute_action' Finished executing action [app-state-show] (0)
I, [2013-11-27T15:38:39.418848 #1037]  INFO -- : openshift.rb:217:in
`execute_parallel_action' execute_parallel_action call - [{:tag=>"",
:gear=>"5295bbf045945bfa0d000035",
:job=>{:cartridge=>"openshift-origin-node", :action=>"app-state-show",
:args=>{"--with-app-uuid"=>"5295bbf045945bfa0d000035",
"--with-app-name"=>"php",
"--with-container-uuid"=>"5295bbf045945bfa0d000035",
"--with-container-name"=>"php", "--with-namespace"=>"frfr",
"--with-request-id"=>"13da5f7e7bc7415c3174d0cb23b49265"}},
:result_stdout=>"started", :result_stderr=>"", :result_exit_code=>0}]
D, [2013-11-27T15:38:39.419094 #1037] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:38:39.419247 #1037] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:38:39.419568 #1037] DEBUG -- : base.rb:168:in
`create_reply' Encoded a message for request
ba5003960d0356e3ad17c6b60f279306
D, [2013-11-27T15:38:39.419833 #1037] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin connector_plugin with class
MCollective::Connector::Activemq
D, [2013-11-27T15:38:39.419990 #1037] DEBUG -- : activemq.rb:266:in
`publish'
Sending a broadcast message to ActiveMQ target
'/queue/mcollective.reply.broker.domain.test.com_1828' with headers '{}'
D, [2013-11-27T15:38:39.420299 #1037] DEBUG -- :
runnerstats.rb:56:in `block
in sent' Incrementing replies stat
D, [2013-11-27T15:38:53.633142 #1037] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:38:53.633595 #1037] DEBUG -- : base.rb:178:in
`create_request' Encoding a request for agent 'registration' in
collective
mcollective with request id 03f640d101605ca2b0990b0af08037cd
D, [2013-11-27T15:38:53.633762 #1037] DEBUG -- : psk.rb:98:in `callerid'
Setting callerid to uid=0 based on callertype=uid
D, [2013-11-27T15:38:53.633938 #1037] DEBUG -- : base.rb:70:in `publish'
Sending registration 03f640d101605ca2b0990b0af08037cd to collective
mcollective
D, [2013-11-27T15:38:53.634317 #1037] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin connector_plugin with class
MCollective::Connector::Activemq
D, [2013-11-27T15:38:53.634815 #1037] DEBUG -- : activemq.rb:266:in
`publish'
Sending a broadcast message to ActiveMQ target
'/topic/mcollective.registration.agent' with headers
'{"reply-to"=>"/queue/mcollective.reply.n1.domain.test.com
<http://domain.test.com>_1037"}'
D, [2013-11-27T15:39:23.635826 #1037] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin security_plugin with class
MCollective::Security::Psk
D, [2013-11-27T15:39:23.636210 #1037] DEBUG -- : base.rb:178:in
`create_request' Encoding a request for agent 'registration' in
collective
mcollective with request id 2f5a8deb0a03565b98c6c1fdc9e48060
D, [2013-11-27T15:39:23.636347 #1037] DEBUG -- : psk.rb:98:in `callerid'
Setting callerid to uid=0 based on callertype=uid
D, [2013-11-27T15:39:23.636529 #1037] DEBUG -- : base.rb:70:in `publish'
Sending registration 2f5a8deb0a03565b98c6c1fdc9e48060 to collective
mcollective
D, [2013-11-27T15:39:23.637672 #1037] DEBUG -- :
pluginmanager.rb:83:in `[]'
Returning cached plugin connector_plugin with class
MCollective::Connector::Activemq
D, [2013-11-27T15:39:23.637878 #1037] DEBUG -- : activemq.rb:266:in
`publish'
Sending a broadcast message to ActiveMQ target
'/topic/mcollective.registration.agent' with headers
'{"reply-to"=>"/queue/mcollective.reply.n1.domain.test.com
<http://domain.test.com>_1037"}'

I don’t see any error in the logs, seems to be OK. Should I look on
other log
files?

Thank you,

Gordan.
Le 27 nov. 2013 à 15:12, Clayton Coleman <ccoleman redhat com
<mailto:ccoleman redhat com>> a écrit :

Unknown means the broker request to mcollective failed or timed
out.  Check
the mcollective and broker logs to verify that the requests are being
received on the node.

On Nov 27, 2013, at 5:18 AM, Gordan Ristic <gr pcsol be
<mailto:gr pcsol be>> wrote:

Hi all,

I have an issue with the status of my apps. They all have unknown
status:
<Capture d’écran 2013-11-27 à 10.57.34.png>
Of course the apps are working perfectly well, I can ssh, use them
and so
on.

Summary of what I’ve done:
1) Installing Openshift Origin broker using
http://openshift.github.io/documentation/oo_deployment_guide_comprehensive.html
but I modified the nightly build with de last stables reps (didn’t
work
on Red Hat 6.4 64b with nightly from scratch)
2) Installing Node on another VM the same way as the broker, with last
stables reps
3) Everything worked perfectly, just impossible to make the
admin-console
working

We are using our ldap for authentication and we need the new web
interface
feature: « share a domain with another user». So I tried to just
update
the broker with the nightly builds.

4) Update the broker with the nightly builds everything was
working (just
had to modify some config for mcollective client) but the status,
quite
annoying :)
5) Tried to update the node, nothing worked anymore so I rolled back

My question is how the broker ask for the app’s status from the node?

Another info: installing a node from scratch on fedora 19 with nightly
builds I get all the infos correctly, but our company absolutely
need to
make it work on red hat :/

Sorry for bothering :)

Gordan


_______________________________________________
users mailing list
users lists openshift redhat com
<mailto:users lists openshift redhat com>
http://lists.openshift.redhat.com/openshiftmm/listinfo/users





_______________________________________________
users mailing list
users lists openshift redhat com
http://lists.openshift.redhat.com/openshiftmm/listinfo/users



--



[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]