Bug 783654

Summary: webadmin - USER_IS_ALREADY_LOGGED_IN - when trying to log in
Product: [Retired] oVirt Reporter: Pavel Stehlik <pstehlik>
Component: ovirt-engine-webadminAssignee: Einav Cohen <ecohen>
Status: CLOSED WONTFIX QA Contact:
Severity: medium Docs Contact:
Priority: unspecified    
Version: unspecifiedCC: acathrow, bazulay, ecohen, iheim, ykaul
Target Milestone: ---   
Target Release: ---   
Hardware: All   
OS: Windows   
Whiteboard: infra
Fixed In Version: Doc Type: Bug Fix
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2012-12-13 08:13:11 UTC Type: ---
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:

Description Pavel Stehlik 2012-01-21 14:41:41 UTC
Description of problem:
 Using IE8 on w2k3. I want to spice to the VM for 1st time from that win - so I was notified about ActiveX, I approved it & then refreash happened - so I was logged off. When trying login again, then USER_IS_ALREADY_LOGGED_IN. 

Then I opened another tab in same IE, & there then I used same link - I can see VMs tab & can open spice console.

Log below (also with previous actions).

Version-Release number of selected component (if applicable):
ovirt-engine-3.0.0_0001-1.2.fc16.x86_64

How reproducible:
it happened :)

Steps to Reproduce:
1. have new user on win, then login to oVirt & try open spice console
2.
3.
  
Actual results:


Expected results:


Additional info:
2012-01-21 15:25:20,960 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVmFromSysPrepVDSCommand] (pool-5-thread-49) START, CreateVmFromSysPrepVDSCommand(vdsId = 0ee9dda0-4287-11e1-9c85-2f744da1f3db, vmId=1f94d894-b1c6-4d6b-96e3-fc657ee3130e, vm=org.ovirt.engine.core.common.businessentities.VM@590eea91, hostName=w-nejsou, domain=), log id: 2936361b
2012-01-21 15:25:21,038 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (pool-5-thread-49) org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVmFromSysPrepVDSCommand kvmEnable=true,nicModel=pv,keyboardLayout=en-us,nice=0,displayNetwork=ovirtmgmt,timeOffset=0,transparentHugePages=true,drives=[Ljava.util.Map;@5fd1cc58,vmId=1f94d894-b1c6-4d6b-96e3-fc657ee3130e,acpiEnable=true,custom={},memSize=1024,boot=cd,smp=4,emulatedMachine=pc-0.14,vmType=kvm,soundDevice=ich6,display=qxl,smpCoresPerSocket=2,spiceMonitors=1,macAddr=00:1a:4a:49:3f:00,bridge=ovirtmgmt,vmName=w-nejsou,sysprepInf=[B@46bed68d,cpuType=Nehalem
2012-01-21 15:25:21,039 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVmFromSysPrepVDSCommand] (pool-5-thread-49) FINISH, CreateVmFromSysPrepVDSCommand, log id: 2936361b
2012-01-21 15:25:21,041 INFO  [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (pool-5-thread-49) IncreasePendingVms::CreateVmIncreasing vds srh-209 pending vcpu count, now 6. Vm: w-nejsou
2012-01-21 15:25:21,049 INFO  [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (pool-5-thread-49) FINISH, CreateVmVDSCommand, return: WaitForLaunch, log id: 16de3f51
2012-01-21 15:26:06,738 INFO  [org.ovirt.engine.core.bll.SetVmTicketCommand] (http--0.0.0.0-8080-6) Running command: SetVmTicketCommand internal: false. Entities affected :  ID: 87d0f7e2-5233-474d-bf36-c57c09b2f594 Type: VM
2012-01-21 15:26:06,743 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (http--0.0.0.0-8080-6) START, SetVmTicketVDSCommand(vdsId = 0ee9dda0-4287-11e1-9c85-2f744da1f3db, vmId=87d0f7e2-5233-474d-bf36-c57c09b2f594, ticket=Vb2pmtCCu/sV, validTime=120), log id: 716d17ed
2012-01-21 15:26:06,770 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (http--0.0.0.0-8080-6) FINISH, SetVmTicketVDSCommand, log id: 716d17ed
2012-01-21 15:26:13,644 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http--0.0.0.0-8080-1) calling GetConfigurationValueQuery with null version, using default general for version
2012-01-21 15:26:13,645 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http--0.0.0.0-8080-1) calling GetConfigurationValueQuery with null version, using default general for version
2012-01-21 15:26:13,645 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http--0.0.0.0-8080-1) calling GetConfigurationValueQuery with null version, using default general for version
2012-01-21 15:26:13,645 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http--0.0.0.0-8080-1) calling GetConfigurationValueQuery with null version, using default general for version
2012-01-21 15:26:13,650 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http--0.0.0.0-8080-1) calling GetConfigurationValueQuery with null version, using default general for version
2012-01-21 15:26:13,651 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http--0.0.0.0-8080-1) calling GetConfigurationValueQuery with null version, using default general for version
2012-01-21 15:26:18,344 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand] (QuartzScheduler_Worker-68) START, UpdateVdsDynamicDataVDSCommand(vdsId = 0ee9dda0-4287-11e1-9c85-2f744da1f3db, vdsDynamic=org.ovirt.engine.core.common.businessentities.VdsDynamic@c4df375e), log id: 7acfa038
2012-01-21 15:26:18,349 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand] (QuartzScheduler_Worker-68) FINISH, UpdateVdsDynamicDataVDSCommand, log id: 7acfa038
2012-01-21 15:26:22,445 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand] (QuartzScheduler_Worker-64) START, UpdateVdsDynamicDataVDSCommand(vdsId = 0ee9dda0-4287-11e1-9c85-2f744da1f3db, vdsDynamic=org.ovirt.engine.core.common.businessentities.VdsDynamic@d0eebbe2), log id: 32e2ccd5
2012-01-21 15:26:22,450 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand] (QuartzScheduler_Worker-64) FINISH, UpdateVdsDynamicDataVDSCommand, log id: 32e2ccd5
2012-01-21 15:26:55,928 WARN  [org.ovirt.engine.core.bll.LoginAdminUserCommand] (http--0.0.0.0-8080-6) CanDoAction of action LoginAdminUser failed. Reasons:USER_IS_ALREADY_LOGGED_IN
2012-01-21 15:27:01,901 WARN  [org.ovirt.engine.core.bll.LoginAdminUserCommand] (http--0.0.0.0-8080-4) CanDoAction of action LoginAdminUser failed. Reasons:USER_IS_ALREADY_LOGGED_IN

Comment 1 Einav Cohen 2012-01-21 16:49:33 UTC
Is there a 100% reproducible scenario?

[BTW, sounds like it might be a backend issue: When pressing F5, we are asking the backend if the current SessionID is associated with a valid-active user session; only if it is not - we are redirecting to the login page; so login shouldn't fail on USER_IS_ALREADY_LOGGED_IN; either the SessionID is associated with a valid-active user session, or not].

Comment 2 Pavel Stehlik 2012-01-21 18:44:59 UTC
I removed Spice object & yes, the same happened when I approve ActiveX again - refresh & User is already logged in.

Comment 4 Itamar Heim 2012-12-13 08:13:11 UTC
Closing old bugs. If this issue is still relevant/important in current version, please re-open the bug.