Bug 1114382
| Summary: | allinone setup fails with 'Session-TTL header was not passed. Not setting TTL value' | ||||||
|---|---|---|---|---|---|---|---|
| Product: | [Retired] oVirt | Reporter: | Yedidyah Bar David <didi> | ||||
| Component: | ovirt-engine-core | Assignee: | Mooli Tayer <mtayer> | ||||
| Status: | CLOSED NEXTRELEASE | QA Contact: | Pavel Stehlik <pstehlik> | ||||
| Severity: | unspecified | Docs Contact: | |||||
| Priority: | unspecified | ||||||
| Version: | 3.5 | CC: | acathrow, bugs, didi, gklein, iheim, oourfali, yeylon | ||||
| Target Milestone: | --- | Keywords: | Triaged | ||||
| Target Release: | 3.5.0 | ||||||
| Hardware: | Unspecified | ||||||
| OS: | Unspecified | ||||||
| Whiteboard: | infra | ||||||
| Fixed In Version: | Doc Type: | Bug Fix | |||||
| Doc Text: | Story Points: | --- | |||||
| Clone Of: | Environment: | ||||||
| Last Closed: | 2014-07-15 12:20:19 UTC | Type: | Bug | ||||
| Regression: | --- | Mount Type: | --- | ||||
| Documentation: | --- | CRM: | |||||
| Verified Versions: | Category: | --- | |||||
| oVirt Team: | Infra | RHEL 7.3 requirements from Atomic Host: | |||||
| Cloudforms Team: | --- | Target Upstream Version: | |||||
| Embargoed: | |||||||
| Attachments: |
|
||||||
Please notice the following issues -
.ovirt.thread.pool-8-thread-3) [690e1997] java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException
2014-06-29 20:03:09,832 ERROR [org.ovirt.engine.core.aaa.filters.RestApiSessionMgmtFilter] (ajp--127.0.0.1-8702-2) Session-TTL header was not passed. Not setting TTL value
2014-06-29 20:03:09,907 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (org.ovirt.thread.pool-8-thread-3) [690e1997] Command PollVDSCommand(HostName = local_host, HostId = d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe) execution failed. Exception: RuntimeException: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException
2014-06-29 20:03:10,409 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (org.ovirt.thread.pool-8-thread-3) [690e1997] java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException
2014-06-29 20:03:10,410 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (org.ovirt.thread.pool-8-thread-3) [690e1997] Command PollVDSCommand(HostName = local_host, HostId = d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe) execution failed. Exception: RuntimeException: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException
2014-06-29 20:03:10,985 ERROR [org.ovirt.engine.core.aaa.filters.RestApiSessionMgmtFilter] (ajp--127.0.0.1-8702-3) Session-TTL header was not passed. Not setting TTL value
2014-06-29 20:03:11,022 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (org.ovirt.thread.pool-8-thread-3) [690e1997] org.ovirt.engine.core.vdsbroker.vdsbroker.VDSRecoveringException: Recovering from crash or Initializing
2014-06-29 20:03:11,023 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (org.ovirt.thread.pool-8-thread-3) [690e1997] Command PollVDSCommand(HostName = local_host, HostId = d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe) execution failed. Exception: VDSRecoveringException: Recovering from crash or Initializing
2014-06-29 20:03:11,530 INFO [org.ovirt.engine.core.bll.network.NetworkConfigurator] (org.ovirt.thread.pool-8-thread-3) [690e1997] Engine managed to communicate with VDSM agent on host local_host
2014-06-29 20:03:11,807 INFO [org.ovirt.engine.core.bll.network.host.SetupNetworksCommand] (org.ovirt.thread.pool-8-thread-3) [510890b9] Running command: SetupNetworksCommand internal: true. Entities affected : ID: d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe Type: VDS
2014-06-29 20:03:11,809 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetupNetworksVDSCommand] (org.ovirt.thread.pool-8-thread-3) [510890b9] START, SetupNetworksVDSCommand(HostName = local_host, HostId = d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe, force=false, checkConnectivity=true, conectivityTimeout=120,
networks=[ovirtmgmt {id=9b6e7f87-acf0-4acf-9b27-059211b57a00, description=Management Network, comment=null, subnet=null, gateway=null, type=null, vlanId=null, stp=false, dataCenterId=ff660f3b-6444-490e-b46e-7560f7290016, mtu=0, vmNetwork=true, cluster=NetworkCluster {id={clusterId=null, networkId=null}, status=OPERATIONAL, display=true, required=true, migration=true}, providedBy=null, label=null, qosId=null}],
bonds=[],
interfaces=[em1 {id=713dce6e-767c-44b8-91fd-e690198d0e9f, vdsId=d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe, macAddress=18:03:73:20:7e:41, networkName=ovirtmgmt, baseInterface=null, vlanId=null, bonded=n
Something is wrong at PollVDSCommand.
The fact engine is flooded with the ugly session messages does not have anything to do to your failures with allinone.
Also, please look at this - 2014-06-29 20:03:20,032 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-54) [fd471de] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe Type: VDS 2014-06-29 20:03:20,056 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-54) [47b1825c] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe Type: VDS 2014-06-29 20:03:20,122 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler_Worker-54) [6232a281] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe Type: VDS 2014-06-29 20:03:20,137 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-54) [6232a281] START, SetVdsStatusVDSCommand(HostName = local_host, HostId = d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe, status=NonOperational, nonOperationalReason=CLUSTER_VERSION_INCOMPATIBLE_WITH_CLUSTER, stopSpmFailureLogged=false), log id: 44e07443 2014-06-29 20:03:20,151 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-54) [6232a281] FINISH, SetVdsStatusVDSCommand, log id: 44e07443 2014-06-29 20:03:20,206 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-54) [6232a281] Correlation ID: 6232a281, Job ID: 9f6afaea-4412-45cf-953b-86eb166b1cb2, Call Stack: null, Custom Event ID: -1, Message: Host local_host is compatible with versions (3.0,3.1,3.2,3.3) and cannot join Cluster local_cluster which is set to version 3.5. 2014-06-29 20:03:20,220 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-54) [6232a281] Host d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe : local_host is already in NonOperational status for reason CLUSTER_VERSION_INCOMPATIBLE_WITH_CLUSTER. SetNonOperationalVds command is skipped. 2014-06-29 20:03:20,755 ERROR [org.ovirt.engine.core.aaa.filters.RestApiSessionMgmtFilter] (ajp--127.0.0.1-8702-6) Session-TTL header was not passed. Not setting TTL value (NonOperationalIssue). Feel free to open a bug about log flooding for the TTL issue. Thanks! According to these entries in the log it looks like the failure might not be relevant to these warnings. So the TTL issue might not be relevant. can this be the reason? 2014-06-29 20:03:20,220 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-54) [6232a281] Host d6c3a7b5-c1e0-45bb-a22f-2a3ad7c6dffe : local_host is already in NonOperational status for reason CLUSTER_VERSION_INCOMPATIBLE_WITH_CLUSTER. SetNonOperationalVds command is skipped. Could you please verify the reason is the host's cluster version is indeed incompatible with cluster's? Closing for now. Didi - if relevant, please reopen. Closing old needinfo's. |
Created attachment 913206 [details] httpd, engine and vdsm logs Description of problem: While running engine-setup with allinone, setup tries to connect the host. While doing that, the engine emits to engine.log lines like: 2014-06-29 20:13:45,470 ERROR [org.ovirt.engine.core.aaa.filters.RestApiSessionMgmtFilter] (ajp--127.0.0.1-8702-6) Session-TTL header was not passed. Not setting TTL value Eventually setup times out and fails. Version-Release number of selected component (if applicable): Latest nightly master build - ovirt-engine-3.5.0-0.0.master.20140627172307.gite5ee98c.fc19.noarch How reproducible: Not sure Steps to Reproduce: 1. Install and setup engine on clean fedora 19 2. 3. Actual results: Fails Expected results: Succeeds Additional info: Attached relevant logs.