maas commissioning api call fails silently if node is declared but powered on

[David Britton]

2015-08-14 20:50:56,331 DEBUG CMD: ['maas', 'admin', 'node', 'commission', u'node-15d1a0f6-42c6-11e5-9d22-5254007c1611']
2015-08-14 20:50:56,598 DEBUG CMD: ['maas', 'admin', 'node', 'commission', u'node-16dca22a-42c6-11e5-b891-5254007c1611']
2015-08-14 20:50:56,859 DEBUG CMD: ['maas', 'admin', 'node', 'commission', u'node-17b20348-42c6-11e5-97d0-5254007c1611']
2015-08-14 20:50:57,122 DEBUG CMD: ['maas', 'admin', 'node', 'commission', u'node-19530bb6-42c6-11e5-9ec4-5254007c1611']
2015-08-14 20:50:57,390 DEBUG CMD: ['maas', 'admin', 'node', 'commission', u'node-19f94314-42c6-11e5-93f7-5254007c1611']
2015-08-14 20:50:57,653 DEBUG CMD: ['maas', 'admin', 'node', 'commission', u'node-1c750aec-42c6-11e5-9d22-5254007c1611']

Apache Log gets the requests:

::1 - - [14/Aug/2015:20:50:56 +0000] "POST /MAAS/api/1.0/nodes/node-15d1a0f6-42c6-11e5-9d22-5254007c1611/?op=commission HTTP/1.1" 200 813 "-" "Python-httplib2/0.8 (gzip)"
::1 - - [14/Aug/2015:20:50:56 +0000] "POST /MAAS/api/1.0/nodes/node-16dca22a-42c6-11e5-b891-5254007c1611/?op=commission HTTP/1.1" 200 801 "-" "Python-httplib2/0.8 (gzip)"
::1 - - [14/Aug/2015:20:50:57 +0000] "POST /MAAS/api/1.0/nodes/node-17b20348-42c6-11e5-97d0-5254007c1611/?op=commission HTTP/1.1" 200 817 "-" "Python-httplib2/0.8 (gzip)"
::1 - - [14/Aug/2015:20:50:57 +0000] "POST /MAAS/api/1.0/nodes/node-19530bb6-42c6-11e5-9ec4-5254007c1611/?op=commission HTTP/1.1" 200 804 "-" "Python-httplib2/0.8 (gzip)"
::1 - - [14/Aug/2015:20:50:57 +0000] "POST /MAAS/api/1.0/nodes/node-19f94314-42c6-11e5-93f7-5254007c1611/?op=commission HTTP/1.1" 200 818 "-" "Python-httplib2/0.8 (gzip)"
::1 - - [14/Aug/2015:20:50:57 +0000] "POST /MAAS/api/1.0/nodes/node-1c750aec-42c6-11e5-9d22-5254007c1611/?op=commission HTTP/1.1" 200 824 "-" "Python-httplib2/0.8 (gzip)"

Maas log only shows one of these attempts:

Aug 14 20:50:57 maas maas.node: [INFO] C240-M4-3: Status transition from NEW to COMMISSIONING
Aug 14 20:50:58 maas maas.node: [INFO] C240-M4-3: Commissioning started

Notice, the 200 return on the maas API call, yet 5 of the calls are silently dropped. Here is an example of the api call on the command line:

2015-08-14 21:16:34,039 DEBUG CMD: ['maas', 'admin', 'node', 'commission', u'node-a7727e24-42c9-11e5-b49b-5254007c1611']
2015-08-14 21:16:34,311 DEBUG STDOUT:
{
    "ip_addresses": [
        "192.168.218.120"
    ],
    "cpu_count": 0,
    "power_type": "ipmi",
    "tag_names": [],
    "swap_size": null,
    "owner": null,
    "macaddress_set": [
        {
            "resource_uri": "/MAAS/api/1.0/nodes/node-a7727e24-42c9-11e5-b49b-5254007c1611/macs/74%3Aa2%3Ae6%3Ad5%3A3d%3Acc/",
            "mac_address": "74:a2:e6:d5:3d:cc"
        },
        {
            "resource_uri": "/MAAS/api/1.0/nodes/node-a7727e24-42c9-11e5-b49b-5254007c1611/macs/a8%3A9d%3A21%3A92%3A74%3A4b/",
            "mac_address": "a8:9d:21:92:74:4b"
        },
        {
            "resource_uri": "/MAAS/api/1.0/nodes/node-a7727e24-42c9-11e5-b49b-5254007c1611/macs/a8%3A9d%3A21%3A92%3A74%3A4c/",
            "mac_address": "a8:9d:21:92:74:4c"
        },
        {
            "resource_uri": "/MAAS/api/1.0/nodes/node-a7727e24-42c9-11e5-b49b-5254007c1611/macs/74%3Aa2%3Ae6%3Ad5%3A3d%3Acd/",
            "mac_address": "74:a2:e6:d5:3d:cd"
        }
    ],
    "zone": {
        "resource_uri": "/MAAS/api/1.0/zones/default/",
        "name": "default",
        "description": ""
    },
    "hostname": "C240-M4-4.gpod",
    "storage": 0,
    "system_id": "node-a7727e24-42c9-11e5-b49b-5254007c1611",
    "boot_type": "fastpath",
    "memory": 0,
    "disable_ipv4": false,
    "status": 0,
    "power_state": "on",
    "routers": null,
    "pxe_mac": null,
    "netboot": true,
    "osystem": "",
    "substatus": 0,
    "architecture": "amd64/generic",
    "distro_series": "",
    "resource_uri": "/MAAS/api/1.0/nodes/node-a7727e24-42c9-11e5-b49b-5254007c1611/"
}

[Andres Rodriguez (andreserl)]

Dear user,

This is an automated message.

We believe this bug report is no longer an issue in the latest version of MAAS. For such reason, we are making this issue as Won't Fix. If you believe this issue is still present in the latest version of MAAS, please re-open this bug report.