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

Re: [Xen-API] xenserver-core tech preview: Console going crazy



This has something to do with running 'xe console' without a tty.  This
breaks:

   ssh <xenserver> xe console vm=foo

Forcing pty allocation works:

   ssh -t <xenserver> xe console vm=foo

        John


On 10/29/2013 01:05 AM, John Morris wrote:
> Next problem:  the VM console proxy exits immediately, resulting in a
> tight loop that eats up about 1/3 of the CPU.  Below is 1.5 cycles
> pasted from the debug log.
> 
>       John
> 
> 
> 
> http://pastebin.ca/2472371
> 
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13264:140387376142272]: stunnel 4.29 on 
>> x86_64-redhat-linux-gnu with OpenSSL 1.0.0-fips 29 Mar 2010
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13264:140387376142272]: 
>> Threading:PTHREAD SSL:ENGINE Sockets:POLL,IPv6 Auth:LIBWRAP
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13264:140387376142272]: stunnel accepted 
>> connection from localhost:#015ÿ#177
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13264:140387376142272]: 
>> connect_blocking: connected 192.168.7.26:443
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13264:140387376142272]: stunnel 
>> connected remote server from 192.168.7.26:45115
>> Oct 29 00:51:45 xen27 stunnel: LOG5[2220:140308671461120]: xapi accepted 
>> connection from ::ffff:192.168.7.26:45115
>> Oct 29 00:51:45 xen27 stunnel: LOG5[2220:140308671461120]: connect_blocking: 
>> connected 127.0.0.1:80
>> Oct 29 00:51:45 xen27 stunnel: LOG5[2220:140308671461120]: xapi connected 
>> remote server from 127.0.0.1:46203
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2352 INET :::80||http] 
>> Request { frame = false; method = CONNECT; uri = /console; query = [ 
>> uuid=6cdba8a9-7be2-2917-ef6d-da09cd31ccb4; 
>> session_id=OpaqueRef:b251dcb4-8f33-a895-1374-2f9e83466c1d ]; content_length 
>> = [ 0 ]; transfer encoding = ; version = 1.0; cookie = [  ]; task = ; 
>> subtask_of = ; content-type = ; host = ; user_agent =  }
>> Oct 29 00:51:45 xen27 xapi: 
>> [20131029T05:51:45.560Z|audit|xen27.zultron.com|2352 INET 
>> :::80|handler:http/connect_console D:19a8eca9ab12|audit] 
>> ('trackid=abc41a624d6cd5ae06e7b279aec28aaf' 'LOCAL_SUPERUSER' 'root' 
>> 'ALLOWED' 'OK' 'HTTP' 'http/connect_console' ())
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2352 INET 
>> :::80||db_write] create_row task 
>> (OpaqueRef:df82fe46-fd33-01ac-a218-5362e2de912c) 
>> [(_ref,v),(uuid,v),(name__label,v),(name__description,v),(allowed_operations,v),(current_operations,v),(created,v),(finished,v),(status,v),(session,v),(resident_on,v),(progress,v),(externalpid,v),(stunnelpid,v),(forwarded,v),(forwarded_to,v),(type,v),(result,v),(error_info,v),(other_config,v),(subtask_of,v)]
>> Oct 29 00:51:45 xen27 xenopsd-xenlight: [xenops_server] VM.stat 
>> 50c8ab69-7fbc-dacd-78e2-230777596993
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2352 INET 
>> :::80|Connection to VM console R:df82fe46fd33|console] VM 
>> OpaqueRef:0ae73118-540b-fc53-4405-05c72422eee9 console on: localhost:9501
>> Oct 29 00:51:45 xen27 stunnel: LOG5[2220:140308671461120]: Connection 
>> closed: 78 bytes sent to SSL, 148 bytes sent to socket
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2352 INET 
>> :::80|Connection to VM console R:df82fe46fd33|console] Connected; running 
>> proxy (between fds: 26 and 27)
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13264:140387376142272]: Connection 
>> closed: 148 bytes sent to SSL, 78 bytes sent to socket
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2352 INET 
>> :::80|Connection to VM console R:df82fe46fd33|console] Proxy exited
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2352 INET 
>> :::80|Connection to VM console R:df82fe46fd33|redo_log] WriteField(task, 
>> OpaqueRef:df82fe46-fd33-01ac-a218-5362e2de912c, allowed_operations, (), ())
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2352 INET 
>> :::80|Connection to VM console R:df82fe46fd33|redo_log] WriteField(task, 
>> OpaqueRef:df82fe46-fd33-01ac-a218-5362e2de912c, finished, 
>> 19700101T00:00:00Z, 20131029T05:51:45Z)
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2352 INET 
>> :::80|Connection to VM console R:df82fe46fd33|redo_log] WriteField(task, 
>> OpaqueRef:df82fe46-fd33-01ac-a218-5362e2de912c, progress, 0, 1)
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2352 INET 
>> :::80|Connection to VM console R:df82fe46fd33|redo_log] WriteField(task, 
>> OpaqueRef:df82fe46-fd33-01ac-a218-5362e2de912c, status, pending, success)
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2352 INET 
>> :::80|Connection to VM console R:df82fe46fd33|db_write] delete_row task 
>> (OpaqueRef:df82fe46-fd33-01ac-a218-5362e2de912c)
> 
> (Here, stunnel restarts)
> 
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13268:140615311181760]: stunnel 4.29 on 
>> x86_64-redhat-linux-gnu with OpenSSL 1.0.0-fips 29 Mar 2010
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13268:140615311181760]: 
>> Threading:PTHREAD SSL:ENGINE Sockets:POLL,IPv6 Auth:LIBWRAP
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13268:140615311181760]: stunnel accepted 
>> connection from localhost:6#177
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13268:140615311181760]: 
>> connect_blocking: connected 192.168.7.26:443
>> Oct 29 00:51:45 xen27 stunnel: LOG5[13268:140615311181760]: stunnel 
>> connected remote server from 192.168.7.26:45118
>> Oct 29 00:51:45 xen27 stunnel: LOG5[2220:140308671461120]: xapi accepted 
>> connection from ::ffff:192.168.7.26:45118
>> Oct 29 00:51:45 xen27 stunnel: LOG5[2220:140308671461120]: connect_blocking: 
>> connected 127.0.0.1:80
>> Oct 29 00:51:45 xen27 stunnel: LOG5[2220:140308671461120]: xapi connected 
>> remote server from 127.0.0.1:46206
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2353 INET :::80||http] 
>> Request { frame = false; method = CONNECT; uri = /console; query = [ 
>> uuid=6cdba8a9-7be2-2917-ef6d-da09cd31ccb4; 
>> session_id=OpaqueRef:b251dcb4-8f33-a895-1374-2f9e83466c1d ]; content_length 
>> = [ 0 ]; transfer encoding = ; version = 1.0; cookie = [  ]; task = ; 
>> subtask_of = ; content-type = ; host = ; user_agent =  }
>> Oct 29 00:51:45 xen27 xapi: 
>> [20131029T05:51:45.727Z|audit|xen27.zultron.com|2353 INET 
>> :::80|handler:http/connect_console D:10a07e7ce7b6|audit] 
>> ('trackid=abc41a624d6cd5ae06e7b279aec28aaf' 'LOCAL_SUPERUSER' 'root' 
>> 'ALLOWED' 'OK' 'HTTP' 'http/connect_console' ())
>> Oct 29 00:51:45 xen27 xapi: [debug|xen27.zultron.com|2353 INET 
>> :::80||db_write] create_row task 
>> (OpaqueRef:aaa8b406-5942-4eaf-ce6b-c9ae783c1bc5) [(_ref,v),(uuid,v),(nam
> 
> 
> 
> _______________________________________________
> Xen-api mailing list
> Xen-api@xxxxxxxxxxxxx
> http://lists.xen.org/cgi-bin/mailman/listinfo/xen-api
> 

_______________________________________________
Xen-api mailing list
Xen-api@xxxxxxxxxxxxx
http://lists.xen.org/cgi-bin/mailman/listinfo/xen-api


 


Rackspace

Lists.xenproject.org is hosted with RackSpace, monitoring our
servers 24x7x365 and backed by RackSpace's Fanatical Support®.