Uploaded image for project: 'XenServer Org'
  1. XenServer Org
  2. XSO-381

Console not found for HVM guests during installation

    XMLWordPrintable

Details

    • Bug
    • Resolution: Done
    • Major
    • None
    • 6.5, Dundee alpha, beta, RC, 6.5 SP1
    • API
    • None

    Description

      This issue only affect Linux HVM guests and during the first install process.

      Booting the HVM guest with a ISO, e.g Ubuntu or Debian. I got a console without any poblem as you can see in the xensource logfile:

      Oct  1 18:04:57 lab2 xapi: [debug|lab2|19 heartbeat|Heartbeat D:828e9557dc5b|mscgen] xapi=>xapi [label="(XML)"];
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|19 heartbeat|Heartbeat D:828e9557dc5b|stunnel] stunnel start
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|19 heartbeat|Heartbeat D:828e9557dc5b|xmlrpc_client] stunnel pid: 27873 (cached = false) connected to 192.168.100.1:443
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|19 heartbeat|Heartbeat D:828e9557dc5b|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=27873
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|mscgen] xapi=>xapi [label="(XML)"];
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|xmlrpc_client] stunnel pid: 2188 (cached = true) connected to 192.168.100.1:443
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=2188
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|xmlrpc_client] stunnel pid: 2188 (cached = true) returned stunnel to cache
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|mscgen] xapi=>xapi [label="(XML)"];
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|xmlrpc_client] stunnel pid: 27598 (cached = true) connected to 192.168.100.1:443
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=27598
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|xmlrpc_client] stunnel pid: 27598 (cached = true) returned stunnel to cache
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|mscgen] xapi=>xapi [label="(XML)"];
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|xmlrpc_client] stunnel pid: 2188 (cached = true) connected to 192.168.100.1:443
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=2188
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|handler:http/connect_console D:3832ea0fd371|xmlrpc_client] stunnel pid: 2188 (cached = true) returned stunnel to cache
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|Connection to VM console R:87332e27c535|mscgen] xapi=>xenops [label="VM.stat"];
      Oct  1 18:04:57 lab2 xenopsd: [debug|lab2|19954|Connection to VM console R:87332e27c535|xenops] VM.stat fdcc1ac0-466d-dfb7-4837-2f68caa6427e
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|Connection to VM console R:87332e27c535|console] VM OpaqueRef:e49c72c8-9d38-cd41-927c-8838ca818ba8 console port: Some 5904
      Oct  1 18:04:57 lab2 xapi: [debug|lab2|17777 INET :::80|Connection to VM console R:87332e27c535|console] Connected; running proxy (between fds: 24 and 29)
      

      Okay so after the initial menu ("Install Ubuntu"), as soon as I pressed the key, the console is cut on XenServer/XAPI side. And the logs are pretty clear:

      Oct  1 18:10:09 lab2 xapi: [debug|lab2|17980 INET :::80|Connection to VM console R:888266122111|console] Proxy exited
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|mscgen] xapi=>xapi [label="(XML)"];
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|xmlrpc_client] stunnel pid: 27598 (cached = true) connected to 192.168.100.1:443
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=27598
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|xmlrpc_client] stunnel pid: 27598 (cached = true) returned stunnel to cache
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|mscgen] xapi=>xapi [label="(XML)"];
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|xmlrpc_client] stunnel pid: 27598 (cached = true) connected to 192.168.100.1:443
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=27598
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|xmlrpc_client] stunnel pid: 27598 (cached = true) returned stunnel to cache
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|mscgen] xapi=>xapi [label="(XML)"];
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|xmlrpc_client] stunnel pid: 27598 (cached = true) connected to 192.168.100.1:443
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=27598
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|handler:http/connect_console D:7fcc9d8153c4|xmlrpc_client] stunnel pid: 27598 (cached = true) returned stunnel to cache
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|Connection to VM console R:9a9954730ee5|mscgen] xapi=>xenops [label="VM.stat"];
      Oct  1 18:10:10 lab2 xenopsd: [debug|lab2|20112|Connection to VM console R:9a9954730ee5|xenops] VM.stat fdcc1ac0-466d-dfb7-4837-2f68caa6427e
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|Connection to VM console R:9a9954730ee5|console] Not_found
      Oct  1 18:10:10 lab2 xapi: [debug|lab2|17981 INET :::80|Connection to VM console R:9a9954730ee5|console] VM OpaqueRef:e49c72c8-9d38-cd41-927c-8838ca818ba8 console port: None
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|mscgen] xapi=>xapi [label="(XML)"];
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|xmlrpc_client] stunnel pid: 27598 (cached = true) connected to 192.168.100.1:443
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=27598
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|xmlrpc_client] stunnel pid: 27598 (cached = true) returned stunnel to cache
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|mscgen] xapi=>xapi [label="(XML)"];
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|xmlrpc_client] stunnel pid: 27598 (cached = true) connected to 192.168.100.1:443
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=27598
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|xmlrpc_client] stunnel pid: 27598 (cached = true) returned stunnel to cache
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|mscgen] xapi=>xapi [label="(XML)"];
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|xmlrpc_client] stunnel pid: 27598 (cached = true) connected to 192.168.100.1:443
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=27598
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|handler:http/connect_console D:49715eaea461|xmlrpc_client] stunnel pid: 27598 (cached = true) returned stunnel to cache
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|Connection to VM console R:50e33bc6ef61|mscgen] xapi=>xenops [label="VM.stat"];
      Oct  1 18:10:13 lab2 xenopsd: [debug|lab2|20113|Connection to VM console R:50e33bc6ef61|xenops] VM.stat fdcc1ac0-466d-dfb7-4837-2f68caa6427e
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|Connection to VM console R:50e33bc6ef61|console] Not_found
      Oct  1 18:10:13 lab2 xapi: [debug|lab2|17982 INET :::80|Connection to VM console R:50e33bc6ef61|console] VM OpaqueRef:e49c72c8-9d38-cd41-927c-8838ca818ba8 console port: None
      

      As you can see, the proxy exited on XenServer. And then we got a console not found, with console port: None.

      Note: I am accessing the console with Xen Orchestra, which is now connecting in RAW HTTP (see https://github.com/vatesfr/xo-server/blob/master/src/proxy-console.js)

      But after this error, even XenCenter can't display anything (see attached screenshot)

      Attachments

        Activity

          People

            andrewcoop Andrew Cooper
            olivierlambert Olivier Lambert
            Votes:
            2 Vote for this issue
            Watchers:
            4 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved: