Project

General

Profile

Feature #6502 » test-result.txt

successfull integration test output - Loïc Dachary, 06/20/2015 07:44 PM

 
=============================================================================================== test session starts ================================================================================================
platform linux2 -- Python 2.7.6 -- py-1.4.28 -- pytest-2.7.1 -- /home/ubuntu/virtualenv/bin/python
rootdir: /home/ubuntu/teuthology, inifile: pytest.ini
collecting ... collected 7 items

teuthology/test/integration/openstack-integration.py::TestSuite::test_suite_noop sudo: unable to resolve host teuthology
* Restarting in-memory queueing server beanstalkd
...done.
2015-06-20 19:29:38,269.269 INFO:root:trying OpenStack cluster the-re
2015-06-20 19:29:38,270.270 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:29:38,271.271 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list
2015-06-20 19:29:39,548.548 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list output +--------------------------------------+------------+--------+--------------------------------------------------------------+
| ID | Name | Status | Networks |
+--------------------------------------+------------+--------+--------------------------------------------------------------+
| ecd351e4-3301-42c5-8126-f25be68155e9 | teuthology | ACTIVE | fsf-lan=10.0.3.31, 93.20.168.190; teuthology-test=10.50.50.2 |
+--------------------------------------+------------+--------+--------------------------------------------------------------+

2015-06-20 19:29:39,552.552 INFO:root:using OpenStack cluster the-re
2015-06-20 19:29:39,552.552 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
2015-06-20 19:29:43,222.222 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
output + cd ../paddles
+ sqlite3 dev.db
+ echo delete from nodes;
+ seq 10 19
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (10, 'the-re010', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (11, 'the-re011', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (12, 'the-re012', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (13, 'the-re013', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (14, 'the-re014', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (15, 'the-re015', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (16, 'the-re016', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (17, 'the-re017', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (18, 'the-re018', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (19, 'the-re019', 'openstack', 1, 0, 1);

2015-06-20 19:29:43,238.238 INFO:root:TestSuite: done worker
2015-06-20 19:29:43,238.238 INFO:root:TestSuite:test_suite_noop
2015-06-20 19:29:43,241.241 INFO:teuthology.suite:suite: noop
2015-06-20 19:29:43,242.242 DEBUG:teuthology.suite:Defaults for machine_type openstack distro None: arch=x86_64, release=centos7, pkg_type=rpm
2015-06-20 19:29:43,242.242 DEBUG:teuthology.suite:Gitbuilder URL: http://gitbuilder.ceph.com/ceph-rpm-centos7-x86_64-basic/ref/master/sha1
2015-06-20 19:29:43,757.757 INFO:teuthology.suite:ceph sha1: d3f34d4c018dd735fa186af8f0ff2a1c68ba33f0
2015-06-20 19:29:43,760.760 DEBUG:teuthology.suite:Defaults for machine_type openstack distro None: arch=x86_64, release=centos7, pkg_type=rpm
2015-06-20 19:29:43,760.760 DEBUG:teuthology.suite:Looking for packages at http://gitbuilder.ceph.com/ceph-rpm-centos7-x86_64-basic/sha1/d3f34d4c018dd735fa186af8f0ff2a1c68ba33f0/version
2015-06-20 19:29:44,102.102 INFO:teuthology.suite:ceph version: v9.0.1-1048.gd3f34d4
2015-06-20 19:29:44,104.104 INFO:teuthology.suite:teuthology branch: master
/home/ubuntu/virtualenv/local/lib/python2.7/site-packages/requests/packages/urllib3/util/ssl_.py:90: InsecurePlatformWarning: A true SSLContext object is not available. This prevents urllib3 from configuring SSL appropriately and may cause certain SSL connections to fail. For more information, see https://urllib3.readthedocs.org/en/latest/security.html#insecureplatformwarning.
InsecurePlatformWarning
2015-06-20 19:29:44,622.622 INFO:teuthology.suite:ceph-qa-suite branch: master
2015-06-20 19:29:44,635.635 DEBUG:teuthology.lock:list_locks: http://localhost:8080/nodes/?count=1&machine_type=openstack
2015-06-20 19:29:44,643.643 DEBUG:teuthology.suite:Suite noop in /home/ubuntu/teuthology/teuthology/test/integration/suites/noop
2015-06-20 19:29:44,643.643 INFO:teuthology.suite:Suite noop in /home/ubuntu/teuthology/teuthology/test/integration/suites/noop generated 1 jobs (not yet filtered)
2015-06-20 19:29:44,645.645 INFO:teuthology.suite:Scheduling noop/{noop.yaml}
Job scheduled with name ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack and ID 1
2015-06-20 19:29:44,844.844 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:29:44,864.864 INFO:teuthology.suite:Suite noop in /home/ubuntu/teuthology/teuthology/test/integration/suites/noop scheduled 1 jobs.
2015-06-20 19:29:44,864.864 INFO:teuthology.suite:Suite noop in /home/ubuntu/teuthology/teuthology/test/integration/suites/noop -- 0 jobs were filtered out.
2015-06-20 19:32:25,507.507 INFO:root:teuthology-worker --tube openstack -l /tmp/tmprNd3nW/log --archive-dir /tmp/tmprNd3nW/archive : stdout stderr 2015-06-20 19:29:43,436.436 INFO:teuthology.repo_utils:Fetching from upstream into /home/ubuntu/src/ceph-qa-suite_master
2015-06-20 19:29:44,475.475 INFO:teuthology.repo_utils:Resetting repo at /home/ubuntu/src/ceph-qa-suite_master to branch master
2015-06-20 19:29:44,835.835 INFO:teuthology.worker:Reserved job 1
2015-06-20 19:29:44,836.836 INFO:teuthology.worker:Config is: branch: master
description: noop/{noop.yaml}
email: null
kernel: {flavor: basic}
last_in_suite: false
machine_type: openstack
name: ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack
nuke-on-error: true
overrides:
admin_socket: {branch: master}
ceph:
conf:
mon: {debug mon: 20, debug ms: 1, debug paxos: 20}
osd: {debug filestore: 20, debug journal: 20, debug ms: 1, debug osd: 20}
log-whitelist: [slow request]
sha1: d3f34d4c018dd735fa186af8f0ff2a1c68ba33f0
ceph-deploy:
branch: {dev: master}
conf:
client: {log file: /var/log/ceph/ceph-$name.$pid.log}
mon: {debug mon: 1, debug ms: 20, debug paxos: 20, osd default pool size: 2}
install:
ceph: {sha1: d3f34d4c018dd735fa186af8f0ff2a1c68ba33f0}
workunit: {sha1: d3f34d4c018dd735fa186af8f0ff2a1c68ba33f0}
owner: scheduled_ubuntu@teuthology
priority: 1000
roles:
- [mon.a, osd.0]
sha1: d3f34d4c018dd735fa186af8f0ff2a1c68ba33f0
stop_worker: true
suite: noop
suite_branch: master
tasks:
- exec:
mon.a: [echo "Well done !"]
teuthology_branch: master
tube: openstack
verbose: true

2015-06-20 19:29:44,855.855 INFO:teuthology.repo_utils:Fetching from upstream into /home/ubuntu/src/ceph-qa-suite_master
2015-06-20 19:29:45,817.817 INFO:teuthology.repo_utils:Resetting repo at /home/ubuntu/src/ceph-qa-suite_master to branch master
2015-06-20 19:29:45,828.828 INFO:teuthology.worker:Creating archive dir /tmp/tmprNd3nW/archive/ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack/1
2015-06-20 19:29:45,829.829 INFO:teuthology.worker:Running job 1
2015-06-20 19:29:45,836.836 INFO:teuthology.worker:Job archive: /tmp/tmprNd3nW/archive/ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack/1
2015-06-20 19:29:45,836.836 INFO:teuthology.worker:Job PID: 32222
2015-06-20 19:29:45,836.836 INFO:teuthology.worker:Running without watchdog
2015-06-20 19:29:46,198.198 DEBUG:teuthology.run:Teuthology command: teuthology /tmp/teuthology-worker.QgmYmi.tmp -- --verbose --lock --description noop/{noop.yaml} --name ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack --block --owner scheduled_ubuntu@teuthology --archive /tmp/tmprNd3nW/archive/ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack/1
2015-06-20 19:29:46,278.278 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:29:46,287.287 DEBUG:teuthology.run:Config:
archive_path: /tmp/tmprNd3nW/archive/ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack/1
branch: master
description: noop/{noop.yaml}
email: null
job_id: '1'
kernel:
flavor: basic
last_in_suite: false
machine_type: openstack
name: ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack
nuke-on-error: true
overrides:
admin_socket:
branch: master
ceph:
conf:
mon:
debug mon: 20
debug ms: 1
debug paxos: 20
osd:
debug filestore: 20
debug journal: 20
debug ms: 1
debug osd: 20
log-whitelist:
- slow request
sha1: d3f34d4c018dd735fa186af8f0ff2a1c68ba33f0
ceph-deploy:
branch:
dev: master
conf:
client:
log file: /var/log/ceph/ceph-$name.$pid.log
mon:
debug mon: 1
debug ms: 20
debug paxos: 20
osd default pool size: 2
install:
ceph:
sha1: d3f34d4c018dd735fa186af8f0ff2a1c68ba33f0
workunit:
sha1: d3f34d4c018dd735fa186af8f0ff2a1c68ba33f0
owner: scheduled_ubuntu@teuthology
priority: 1000
roles:
- - mon.a
- osd.0
sha1: d3f34d4c018dd735fa186af8f0ff2a1c68ba33f0
stop_worker: true
suite: noop
suite_branch: master
suite_path: /home/ubuntu/src/ceph-qa-suite_master
tasks:
- exec:
mon.a:
- echo "Well done !"
teuthology_branch: master
tube: openstack
verbose: true
worker_log: /tmp/tmprNd3nW/log/worker.openstack.32196
2015-06-20 19:29:46,287.287 INFO:teuthology.run:suite_path is set to /home/ubuntu/src/ceph-qa-suite_master; will attempt to use it
2015-06-20 19:29:46,287.287 INFO:teuthology.run:Found tasks at /home/ubuntu/src/ceph-qa-suite_master/tasks
2015-06-20 19:29:46,291.291 INFO:teuthology.run_tasks:Running task internal.check_packages...
2015-06-20 19:29:46,291.291 INFO:teuthology.task.internal:Checking packages...
2015-06-20 19:29:46,291.291 INFO:teuthology.task.internal:Checking packages skipped, missing os_type 'None' or ceph hash 'd3f34d4c018dd735fa186af8f0ff2a1c68ba33f0'
2015-06-20 19:29:46,292.292 INFO:teuthology.run_tasks:Running task internal.lock_machines...
2015-06-20 19:29:46,292.292 INFO:teuthology.task.internal:Locking machines...
2015-06-20 19:29:46,292.292 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:29:46,292.292 DEBUG:teuthology.lock:list_locks: http://localhost:8080/nodes/?count=6&locked=0&up=1&machine_type=openstack
2015-06-20 19:29:46,303.303 DEBUG:teuthology.lock:lock_many request: {'count': 1, 'locked_by': 'scheduled_ubuntu@teuthology', 'description': '/tmp/tmprNd3nW/archive/ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack/1', 'machine_type': 'openstack'}
2015-06-20 19:29:46,509.509 DEBUG:teuthology.lock:locked the-re010
2015-06-20 19:29:46,551.551 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:29:46,552.552 DEBUG:teuthology.provision:OpenStack:destroy
2015-06-20 19:29:46,553.553 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:29:47,552.552 ERROR:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 error ERROR: openstack No server with a name or ID of 'the-re010' exists.

2015-06-20 19:29:47,553.553 DEBUG:teuthology.provision:OpenStack:create
2015-06-20 19:29:47,553.553 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack network show -f json teuthology-test
2015-06-20 19:29:48,530.530 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack network show -f json teuthology-test output [{"Field": "id", "Value": "582950be-f33c-4375-8f8e-14606143e6d7"}, {"Field": "name", "Value": "teuthology-test"}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "router_type", "Value": "Internal"}, {"Field": "shared", "Value": false}, {"Field": "state", "Value": "UP"}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "subnets", "Value": "5ecec13c-df5b-42f5-9f54-2bf1c2d95d9d"}]

2015-06-20 19:29:48,530.530 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack flavor list -f json
2015-06-20 19:29:49,464.464 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack flavor list -f json output [{"ID": "01912b08-dfe0-480e-9b38-5ba8c310e08f", "Name": "2cpu-3G", "RAM": 3192, "Disk": 10, "Ephemeral": 0, "VCPUs": 2, "Is Public": true}, {"ID": "1", "Name": "m1.tiny", "RAM": 512, "Disk": 1, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "2", "Name": "m1.small", "RAM": 1024, "Disk": 10, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "24f09411-ab77-468c-b42c-93d7168f87f6", "Name": "1cpu-256M", "RAM": 256, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "3", "Name": "m1.medium", "RAM": 3192, "Disk": 10, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "4", "Name": "m1.large", "RAM": 8192, "Disk": 80, "Ephemeral": 0, "VCPUs": 4, "Is Public": true}, {"ID": "4ed21e7a-52a6-4b0f-9754-74ae925109b6", "Name": "1cpu-512M", "RAM": 512, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "5", "Name": "m1.xlarge", "RAM": 16384, "Disk": 160, "Ephemeral": 0, "VCPUs": 8, "Is Public": true}, {"ID": "b1bbe2bd-c3bd-45a4-9a3e-704547ab0c69", "Name": "2cpu-4G", "RAM": 4096, "Disk": 0, "Ephemeral": 0, "VCPUs": 2, "Is Public": true}, {"ID": "c16e3f8b-c9ce-442b-8cfa-a23aeff6928c", "Name": "6cpu-8G", "RAM": 8192, "Disk": 0, "Ephemeral": 0, "VCPUs": 6, "Is Public": true}, {"ID": "c7798fdc-a3b0-4512-8c21-43227e987801", "Name": "1cpu-1G", "RAM": 1024, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "f52f848c-6efc-43e7-96d0-d3b04686881b", "Name": "1cpu-2G", "RAM": 2048, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "fe0a54e0-3552-479d-9374-1b131486a0de", "Name": "1cpu-4G", "RAM": 4096, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}]

2015-06-20 19:29:49,529.529 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack volume show -f json the-re010-0
2015-06-20 19:29:50,642.642 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack volume show -f json the-re010-0 output [{"Field": "attachments", "Value": []}, {"Field": "availability_zone", "Value": "ovh"}, {"Field": "bootable", "Value": "false"}, {"Field": "created_at", "Value": "2015-06-14T16:57:58.000000"}, {"Field": "display_description", "Value": null}, {"Field": "display_name", "Value": "the-re010-0"}, {"Field": "id", "Value": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}, {"Field": "properties", "Value": "readonly='False'"}, {"Field": "size", "Value": 1}, {"Field": "snapshot_id", "Value": null}, {"Field": "source_volid", "Value": null}, {"Field": "status", "Value": "available"}, {"Field": "type", "Value": "ovh"}]

2015-06-20 19:29:50,643.643 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server create --availability-zone ovh --block-device-mapping /dev/vdb=ab5b1622-2db5-4e95-80c4-9384f0e43bdd --image ubuntu-trusty-14.04 --flavor m1.small --key-name teuthology --user-data /tmp/tmponwuvT --nic net-id=582950be-f33c-4375-8f8e-14606143e6d7,v4-fixed-ip=10.50.50.10 --wait the-re010
2015-06-20 19:30:07,127.127 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server create --availability-zone ovh --block-device-mapping /dev/vdb=ab5b1622-2db5-4e95-80c4-9384f0e43bdd --image ubuntu-trusty-14.04 --flavor m1.small --key-name teuthology --user-data /tmp/tmponwuvT --nic net-id=582950be-f33c-4375-8f8e-14606143e6d7,v4-fixed-ip=10.50.50.10 --wait the-re010 output
+--------------------------------------+------------------------------------------------------------+
| Field | Value |
+--------------------------------------+------------------------------------------------------------+
| OS-DCF:diskConfig | MANUAL |
| OS-EXT-AZ:availability_zone | ovh |
| OS-EXT-STS:power_state | 1 |
| OS-EXT-STS:task_state | None |
| OS-EXT-STS:vm_state | active |
| OS-SRV-USG:launched_at | 2015-06-20T19:30:02.000000 |
| OS-SRV-USG:terminated_at | None |
| accessIPv4 | |
| accessIPv6 | |
| addresses | teuthology-test=10.50.50.10 |
| adminPass | M4ZmnVmW5UK7 |
| config_drive | |
| created | 2015-06-20T19:29:52Z |
| flavor | m1.small (2) |
| hostId | 6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162 |
| id | 81a6e000-7521-4bbf-b69f-024e9232a71d |
| image | ubuntu-trusty-14.04 (62d1c667-f5bb-4754-8606-3479569fd5fe) |
| key_name | teuthology |
| name | the-re010 |
| os-extended-volumes:volumes_attached | [{u'id': u'ab5b1622-2db5-4e95-80c4-9384f0e43bdd'}] |
| progress | 0 |
| project_id | a5fa44393fbf4a1fa006d83b996595ef |
| properties | |
| security_groups | [{u'name': u'default'}] |
| status | ACTIVE |
| updated | 2015-06-20T19:30:02Z |
| user_id | 0df7d9fa2d694b59821acd1d6c0e2291 |
+--------------------------------------+------------------------------------------------------------+

2015-06-20 19:31:08,484.484 DEBUG:teuthology.provision:cloud_init_wait
2015-06-20 19:31:08,874.874 DEBUG:teuthology.provision:cloud_init_wait grep 'The system is finally up' /var/log/cloud-init.log
2015-06-20 19:31:10,182.182 DEBUG:teuthology.provision:cloud_init_wait stdout grep 'The system is finally up' /var/log/cloud-init.log Jun 20 19:30:42 the-re010 [CLOUDINIT] util.py[DEBUG]: The system is finally up, after 38.36 seconds

2015-06-20 19:31:10,183.183 DEBUG:teuthology.provision:cloud_init_wait stderr grep 'The system is finally up' /var/log/cloud-init.log
2015-06-20 19:31:10,211.211 INFO:teuthology.task.internal:Waiting for virtual machines to come up
2015-06-20 19:31:20,246.246 INFO:teuthology.task.internal:virtual machine is still unavailable
2015-06-20 19:31:20,246.246 DEBUG:teuthology.lock:list_locks: http://localhost:8080/nodes/
2015-06-20 19:31:20,277.277 INFO:teuthology.lock:Checking the-re010
2015-06-20 19:31:20,278.278 INFO:teuthology.lock:New key found. Updating...
2015-06-20 19:31:20,525.525 INFO:teuthology.task.internal:Locked targets:
the-re010: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDnN5gYFjFGQADGTZ4QNjMysOU5PofnWDikRKLag16b1vJMQwFpUNbPlp25oRfA5skam2Ogck5AQgnh+KhLXPCyNkCpsQ32Yw4Yxtm060OGGV1sLFeM72nwk6s80cvI82R3H4AQxEzygmQkh3yTTtmf4UUl59VrlktjUM9hYxJ+Vi68gEhu8RftfkY0R25ReibIz6QO3wB+7NQmQ3eJ3kYwEOXtx2Ks8hVitld235fNdKAt1qekQzVhAMLn03YgiXOQ9iBDKniebwS0pNuTYgC3APh2EzRhDmeAXO9+0TBU82i5jtIC/2AKUoymqWpSnOc5LLivnOUUfEkIClfhcv7x
2015-06-20 19:31:20,526.526 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:31:20,526.526 INFO:teuthology.run_tasks:Running task internal.save_config...
2015-06-20 19:31:20,526.526 INFO:teuthology.task.internal:Saving configuration
2015-06-20 19:31:20,536.536 INFO:teuthology.run_tasks:Running task internal.check_lock...
2015-06-20 19:31:20,536.536 INFO:teuthology.task.internal:Checking locks...
2015-06-20 19:31:20,547.547 DEBUG:teuthology.task.internal:machine status is {u'is_vm': True, u'locked': True, u'locked_since': u'2015-06-20 19:29:46.310051', u'locked_by': u'scheduled_ubuntu@teuthology', u'up': True, u'mac_address': None, u'name': u'the-re010', u'os_version': None, u'machine_type': u'openstack', u'vm_host': None, u'os_type': None, u'arch': None, u'ssh_pub_key': u'ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDnN5gYFjFGQADGTZ4QNjMysOU5PofnWDikRKLag16b1vJMQwFpUNbPlp25oRfA5skam2Ogck5AQgnh+KhLXPCyNkCpsQ32Yw4Yxtm060OGGV1sLFeM72nwk6s80cvI82R3H4AQxEzygmQkh3yTTtmf4UUl59VrlktjUM9hYxJ+Vi68gEhu8RftfkY0R25ReibIz6QO3wB+7NQmQ3eJ3kYwEOXtx2Ks8hVitld235fNdKAt1qekQzVhAMLn03YgiXOQ9iBDKniebwS0pNuTYgC3APh2EzRhDmeAXO9+0TBU82i5jtIC/2AKUoymqWpSnOc5LLivnOUUfEkIClfhcv7x', u'description': u'/tmp/tmprNd3nW/archive/ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack/1'}
2015-06-20 19:31:20,548.548 INFO:teuthology.run_tasks:Running task internal.add_remotes...
2015-06-20 19:31:20,548.548 INFO:teuthology.task.internal:roles: the-re010 - ['mon.a', 'osd.0']
2015-06-20 19:31:20,548.548 INFO:teuthology.run_tasks:Running task internal.connect...
2015-06-20 19:31:20,549.549 INFO:teuthology.task.internal:Opening connections...
2015-06-20 19:31:20,549.549 DEBUG:teuthology.task.internal:connecting to the-re010
2015-06-20 19:31:20,549.549 INFO:teuthology.orchestra.connection:{'username': None, 'hostname': u'the-re010', 'timeout': 60}
2015-06-20 19:31:20,702.702 INFO:teuthology.run_tasks:Running task internal.push_inventory...
2015-06-20 19:31:20,703.703 INFO:teuthology.orchestra.run.the-re010:Running: 'hostname --fqdn'
2015-06-20 19:31:20,914.914 INFO:teuthology.orchestra.run.the-re010:Running: 'uname -m'
2015-06-20 19:31:20,987.987 INFO:teuthology.orchestra.run.the-re010:Running: "python -c 'import platform; print platform.linux_distribution()'"
2015-06-20 19:31:21,078.078 INFO:teuthology.lock:Updating the-re010 on lock server
2015-06-20 19:31:21,207.207 INFO:teuthology.run_tasks:Running task internal.serialize_remote_roles...
2015-06-20 19:31:21,211.211 INFO:teuthology.run_tasks:Running task internal.check_conflict...
2015-06-20 19:31:21,212.212 INFO:teuthology.task.internal:Checking for old test directory...
2015-06-20 19:31:21,213.213 INFO:teuthology.orchestra.run.the-re010:Running: "test '!' -e /home/ubuntu/cephtest"
2015-06-20 19:31:21,219.219 INFO:teuthology.run_tasks:Running task internal.check_ceph_data...
2015-06-20 19:31:21,220.220 INFO:teuthology.task.internal:Checking for old /var/lib/ceph...
2015-06-20 19:31:21,220.220 INFO:teuthology.orchestra.run.the-re010:Running: "test '!' -e /var/lib/ceph"
2015-06-20 19:31:21,290.290 INFO:teuthology.run_tasks:Running task internal.vm_setup...
2015-06-20 19:31:21,291.291 INFO:teuthology.task.internal:vm_setup ctx = {'': True, 'suite_path': None, 'verbose': True, 'name': 'ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack', 'cluster': Cluster(remotes=[[Remote(name=u'the-re010'), ['mon.a', 'osd.0']]]), 'lock': True, 'description': 'noop/{noop.yaml}', 'summary': {'owner': 'scheduled_ubuntu@teuthology', 'description': 'noop/{noop.yaml}', 'success': True}, 'os_version': None, 'teuthology_config': {'lock_server': 'http://localhost:8080/', 'queue_port': 11300, 'lab_domain': 'openstacklocal', 'openstack': {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}, 'teuthology_path': '.', 'queue_host': 'localhost', 'canonicalize_hostname': False, 'results_server': None}, 'version': False, 'machine_type': 'openstack', 'owner': 'scheduled_ubuntu@teuthology', 'os_type': None, 'config': {'kernel': {'flavor': 'basic'}, 'tasks': [{'internal.check_packages': None}, {'internal.lock_machines': (1, 'openstack')}, {'internal.save_config': None}, {'internal.check_lock': None}, {'internal.add_remotes': None}, {'internal.connect': None}, {'internal.push_inventory': None}, {'internal.serialize_remote_roles': None}, {'internal.check_conflict': None}, {'internal.check_ceph_data': None}, {'internal.vm_setup': None}, {'internal.base': None}, {'internal.archive': None}, {'internal.coredump': None}, {'internal.sudo': None}, {'internal.syslog': None}, {'internal.timer': None}, {'exec': {'mon.a': ['echo "Well done !"']}}], 'suite_path': '/home/ubuntu/src/ceph-qa-suite_master', 'verbose': True, 'stop_worker': True, 'worker_log': '/tmp/tmprNd3nW/log/worker.openstack.32196', 'owner': 'scheduled_ubuntu@teuthology', 'targets': {u'the-re010': u'ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDnN5gYFjFGQADGTZ4QNjMysOU5PofnWDikRKLag16b1vJMQwFpUNbPlp25oRfA5skam2Ogck5AQgnh+KhLXPCyNkCpsQ32Yw4Yxtm060OGGV1sLFeM72nwk6s80cvI82R3H4AQxEzygmQkh3yTTtmf4UUl59VrlktjUM9hYxJ+Vi68gEhu8RftfkY0R25ReibIz6QO3wB+7NQmQ3eJ3kYwEOXtx2Ks8hVitld235fNdKAt1qekQzVhAMLn03YgiXOQ9iBDKniebwS0pNuTYgC3APh2EzRhDmeAXO9+0TBU82i5jtIC/2AKUoymqWpSnOc5LLivnOUUfEkIClfhcv7x'}, 'job_id': '1', 'tube': 'openstack', 'suite_branch': 'master', 'priority': 1000, 'branch': 'master', 'suite': 'noop', 'email': None, 'archive_path': '/tmp/tmprNd3nW/archive/ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack/1', 'description': 'noop/{noop.yaml}', 'nuke-on-error': True, 'last_in_suite': False, 'machine_type': 'openstack', 'teuthology_branch': 'master', 'sha1': 'd3f34d4c018dd735fa186af8f0ff2a1c68ba33f0', 'name': 'ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack', 'roles': [['mon.a', 'osd.0']], 'overrides': {'ceph': {'log-whitelist': ['slow request'], 'conf': {'mon': {'debug mon': 20, 'debug paxos': 20, 'debug ms': 1}, 'osd': {'debug osd': 20, 'debug filestore': 20, 'debug journal': 20, 'debug ms': 1}}, 'sha1': 'd3f34d4c018dd735fa186af8f0ff2a1c68ba33f0'}, 'ceph-deploy': {'branch': {'dev': 'master'}, 'conf': {'client': {'log file': '/var/log/ceph/ceph-$name.$pid.log'}, 'mon': {'osd default pool size': 2, 'debug mon': 1, 'debug paxos': 20, 'debug ms': 20}}}, 'workunit': {'sha1': 'd3f34d4c018dd735fa186af8f0ff2a1c68ba33f0'}, 'install': {'ceph': {'sha1': 'd3f34d4c018dd735fa186af8f0ff2a1c68ba33f0'}}, 'admin_socket': {'branch': 'master'}}}, 'archive': '/tmp/tmprNd3nW/archive/ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack/1', 'block': True, 'help': False} config = None
2015-06-20 19:31:21,306.306 INFO:teuthology.orchestra.run.the-re010:Running: 'test -e /ceph-qa-ready'
2015-06-20 19:31:21,342.342 INFO:teuthology.task.internal:edit /etc/sudoers on the-re010
@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
@ WARNING: REMOTE HOST IDENTIFICATION HAS CHANGED! @
@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
IT IS POSSIBLE THAT SOMEONE IS DOING SOMETHING NASTY!
Someone could be eavesdropping on you right now (man-in-the-middle attack)!
It is also possible that a host key has just been changed.
The fingerprint for the ECDSA key sent by the remote host is
db:fa:04:5d:35:7c:27:5a:2f:93:7c:bc:9a:cb:85:93.
Please contact your system administrator.
Add correct host key in /home/ubuntu/.ssh/known_hosts to get rid of this message.
Offending ECDSA key in /home/ubuntu/.ssh/known_hosts:1
remove with: ssh-keygen -f "/home/ubuntu/.ssh/known_hosts" -R the-re010
Password authentication is disabled to avoid man-in-the-middle attacks.
Keyboard-interactive authentication is disabled to avoid man-in-the-middle attacks.
Connection to the-re010 closed.
2015-06-20 19:31:22,096.096 INFO:teuthology.run_tasks:Running task internal.base...
2015-06-20 19:31:22,096.096 INFO:teuthology.task.internal:Creating test directory...
2015-06-20 19:31:22,097.097 INFO:teuthology.orchestra.run.the-re010:Running: 'mkdir -p -m0755 -- /home/ubuntu/cephtest'
2015-06-20 19:31:22,107.107 INFO:teuthology.run_tasks:Running task internal.archive...
2015-06-20 19:31:22,108.108 INFO:teuthology.task.internal:Creating archive directory...
2015-06-20 19:31:22,108.108 INFO:teuthology.orchestra.run.the-re010:Running: 'install -d -m0755 -- /home/ubuntu/cephtest/archive'
2015-06-20 19:31:22,188.188 INFO:teuthology.run_tasks:Running task internal.coredump...
2015-06-20 19:31:22,189.189 INFO:teuthology.task.internal:Enabling coredump saving...
2015-06-20 19:31:22,189.189 INFO:teuthology.orchestra.run.the-re010:Running: 'install -d -m0755 -- /home/ubuntu/cephtest/archive/coredump && sudo sysctl -w kernel.core_pattern=/home/ubuntu/cephtest/archive/coredump/%t.%p.core'
2015-06-20 19:31:22,330.330 INFO:teuthology.orchestra.run.the-re010.stdout:kernel.core_pattern = /home/ubuntu/cephtest/archive/coredump/%t.%p.core
2015-06-20 19:31:22,332.332 INFO:teuthology.run_tasks:Running task internal.sudo...
2015-06-20 19:31:22,332.332 INFO:teuthology.task.internal:Configuring sudo...
2015-06-20 19:31:22,333.333 INFO:teuthology.orchestra.run.the-re010:Running: "sudo sed -i.orig.teuthology -e 's/^\\([^#]*\\) \\(requiretty\\)/\\1 !\\2/g' -e 's/^\\([^#]*\\) !\\(visiblepw\\)/\\1 \\2/g' /etc/sudoers"
2015-06-20 19:31:22,349.349 INFO:teuthology.run_tasks:Running task internal.syslog...
2015-06-20 19:31:22,350.350 INFO:teuthology.task.internal:Starting syslog monitoring...
2015-06-20 19:31:22,350.350 INFO:teuthology.orchestra.run.the-re010:Running: 'mkdir -p -m0755 -- /home/ubuntu/cephtest/archive/syslog'
2015-06-20 19:31:22,420.420 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo python -c \'import shutil, sys; shutil.copyfileobj(sys.stdin, file(sys.argv[1], "wb"))\' /etc/rsyslog.d/80-cephtest.conf'
2015-06-20 19:31:22,531.531 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo service rsyslog restart'
2015-06-20 19:31:22,634.634 INFO:teuthology.orchestra.run.the-re010.stdout:rsyslog stop/waiting
2015-06-20 19:31:22,655.655 INFO:teuthology.orchestra.run.the-re010.stdout:rsyslog start/running, process 1570
2015-06-20 19:31:22,657.657 INFO:teuthology.run_tasks:Running task internal.timer...
2015-06-20 19:31:22,657.657 INFO:teuthology.task.internal:Starting timer...
2015-06-20 19:31:22,657.657 INFO:teuthology.run_tasks:Running task exec...
2015-06-20 19:31:22,658.658 INFO:teuthology.task.exec:Executing custom commands...
2015-06-20 19:31:22,659.659 INFO:teuthology.task.exec:Running commands on role mon.a host the-re010
2015-06-20 19:31:22,659.659 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo TESTDIR=/home/ubuntu/cephtest bash -c \'echo "Well done !"\''
2015-06-20 19:31:22,743.743 INFO:teuthology.orchestra.run.the-re010.stdout:Well done !
2015-06-20 19:31:22,744.744 DEBUG:teuthology.run_tasks:Unwinding manager internal.timer
2015-06-20 19:31:22,744.744 INFO:teuthology.task.internal:Duration was 0.086540 seconds
2015-06-20 19:31:22,744.744 DEBUG:teuthology.run_tasks:Unwinding manager internal.syslog
2015-06-20 19:31:22,744.744 INFO:teuthology.task.internal:Shutting down syslog monitoring...
2015-06-20 19:31:22,745.745 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo rm -f -- /etc/rsyslog.d/80-cephtest.conf && sudo service rsyslog restart'
2015-06-20 19:31:22,845.845 INFO:teuthology.orchestra.run.the-re010.stdout:rsyslog stop/waiting
2015-06-20 19:31:22,864.864 INFO:teuthology.orchestra.run.the-re010.stdout:rsyslog start/running, process 1596
2015-06-20 19:31:22,865.865 INFO:teuthology.task.internal:Checking logs for errors...
2015-06-20 19:31:22,865.865 DEBUG:teuthology.task.internal:Checking the-re010
2015-06-20 19:31:22,866.866 INFO:teuthology.orchestra.run.the-re010:Running: "egrep --binary-files=text '\\bBUG\\b|\\bINFO\\b|\\bDEADLOCK\\b' /home/ubuntu/cephtest/archive/syslog/*.log | grep -v 'task .* blocked for more than .* seconds' | grep -v 'lockdep is turned off' | grep -v 'trying to register non-static key' | grep -v 'DEBUG: fsize' | grep -v CRON | grep -v 'BUG: bad unlock balance detected' | grep -v 'inconsistent lock state' | grep -v '*** DEADLOCK ***' | grep -v 'INFO: possible irq lock inversion dependency detected' | grep -v 'INFO: NMI handler (perf_event_nmi_handler) took too long to run' | grep -v 'INFO: recovery required on readonly' | head -n 1"
2015-06-20 19:31:22,951.951 INFO:teuthology.orchestra.run.the-re010.stderr:egrep: /home/ubuntu/cephtest/archive/syslog/*.log: No such file or directory
2015-06-20 19:31:22,953.953 INFO:teuthology.task.internal:Compressing syslogs...
2015-06-20 19:31:22,953.953 INFO:teuthology.orchestra.run.the-re010:Running: "find /home/ubuntu/cephtest/archive/syslog -name '*.log' -print0 | sudo xargs -0 --no-run-if-empty -- gzip --"
2015-06-20 19:31:23,036.036 DEBUG:teuthology.run_tasks:Unwinding manager internal.sudo
2015-06-20 19:31:23,036.036 INFO:teuthology.task.internal:Restoring /etc/sudoers...
2015-06-20 19:31:23,037.037 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo mv -f /etc/sudoers.orig.teuthology /etc/sudoers'
2015-06-20 19:31:23,120.120 DEBUG:teuthology.run_tasks:Unwinding manager internal.coredump
2015-06-20 19:31:23,121.121 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo sysctl -w kernel.core_pattern=core && rmdir --ignore-fail-on-non-empty -- /home/ubuntu/cephtest/archive/coredump'
2015-06-20 19:31:23,203.203 INFO:teuthology.orchestra.run.the-re010.stdout:kernel.core_pattern = core
2015-06-20 19:31:23,257.257 INFO:teuthology.orchestra.run.the-re010:Running: "if test '!' -e /home/ubuntu/cephtest/archive/coredump ; then echo OK ; fi"
2015-06-20 19:31:23,327.327 DEBUG:teuthology.run_tasks:Unwinding manager internal.archive
2015-06-20 19:31:23,328.328 INFO:teuthology.task.internal:Transferring archived files...
2015-06-20 19:31:23,328.328 DEBUG:teuthology.misc:Transferring archived files from the-re010:/home/ubuntu/cephtest/archive to /tmp/tmprNd3nW/archive/ubuntu-2015-06-20_19:29:43-noop-master---basic-openstack/1/remote/the-re010
2015-06-20 19:31:23,353.353 INFO:teuthology.orchestra.run.the-re010:Running: "python -c 'import os; import tempfile; import sys;(fd,fname) = tempfile.mkstemp();os.close(fd);sys.stdout.write(fname.rstrip());sys.stdout.flush()'"
2015-06-20 19:31:23,391.391 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo tar cz -f /tmp/tmpyK5bH2 -C /home/ubuntu/cephtest/archive -- .'
2015-06-20 19:31:23,485.485 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo chmod 0666 /tmp/tmpyK5bH2'
2015-06-20 19:31:23,663.663 INFO:teuthology.orchestra.run.the-re010:Running: 'rm -fr /tmp/tmpyK5bH2'
2015-06-20 19:31:23,671.671 INFO:teuthology.task.internal:Removing archive directory...
2015-06-20 19:31:23,671.671 INFO:teuthology.orchestra.run.the-re010:Running: 'rm -rf -- /home/ubuntu/cephtest/archive'
2015-06-20 19:31:23,744.744 DEBUG:teuthology.run_tasks:Unwinding manager internal.base
2015-06-20 19:31:23,744.744 INFO:teuthology.task.internal:Tidying up after the test...
2015-06-20 19:31:23,745.745 INFO:teuthology.orchestra.run.the-re010:Running: 'rmdir -- /home/ubuntu/cephtest'
2015-06-20 19:31:23,817.817 DEBUG:teuthology.run_tasks:Unwinding manager internal.lock_machines
2015-06-20 19:31:23,817.817 INFO:teuthology.task.internal:Unlocking machines...
2015-06-20 19:31:23,834.834 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:31:23,835.835 DEBUG:teuthology.provision:OpenStack:destroy
2015-06-20 19:31:23,835.835 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:31:25,850.850 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 output [{"Field": "OS-DCF:diskConfig", "Value": "MANUAL"}, {"Field": "OS-EXT-AZ:availability_zone", "Value": "ovh"}, {"Field": "OS-EXT-STS:power_state", "Value": 1}, {"Field": "OS-EXT-STS:task_state", "Value": null}, {"Field": "OS-EXT-STS:vm_state", "Value": "active"}, {"Field": "OS-SRV-USG:launched_at", "Value": "2015-06-20T19:30:02.000000"}, {"Field": "OS-SRV-USG:terminated_at", "Value": null}, {"Field": "accessIPv4", "Value": ""}, {"Field": "accessIPv6", "Value": ""}, {"Field": "addresses", "Value": "teuthology-test=10.50.50.10"}, {"Field": "config_drive", "Value": ""}, {"Field": "created", "Value": "2015-06-20T19:29:52Z"}, {"Field": "flavor", "Value": "m1.small (2)"}, {"Field": "hostId", "Value": "6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162"}, {"Field": "id", "Value": "81a6e000-7521-4bbf-b69f-024e9232a71d"}, {"Field": "image", "Value": "ubuntu-trusty-14.04 (62d1c667-f5bb-4754-8606-3479569fd5fe)"}, {"Field": "key_name", "Value": "teuthology"}, {"Field": "name", "Value": "the-re010"}, {"Field": "os-extended-volumes:volumes_attached", "Value": [{"id": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}]}, {"Field": "progress", "Value": 0}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "properties", "Value": ""}, {"Field": "security_groups", "Value": [{"name": "default"}]}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "updated", "Value": "2015-06-20T19:30:02Z"}, {"Field": "user_id", "Value": "0df7d9fa2d694b59821acd1d6c0e2291"}]

2015-06-20 19:31:25,850.850 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server delete the-re010
2015-06-20 19:31:27,490.490 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server delete the-re010 output
2015-06-20 19:31:27,490.490 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:31:28,845.845 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 output [{"Field": "OS-DCF:diskConfig", "Value": "MANUAL"}, {"Field": "OS-EXT-AZ:availability_zone", "Value": "ovh"}, {"Field": "OS-EXT-STS:power_state", "Value": 1}, {"Field": "OS-EXT-STS:task_state", "Value": "deleting"}, {"Field": "OS-EXT-STS:vm_state", "Value": "active"}, {"Field": "OS-SRV-USG:launched_at", "Value": "2015-06-20T19:30:02.000000"}, {"Field": "OS-SRV-USG:terminated_at", "Value": null}, {"Field": "accessIPv4", "Value": ""}, {"Field": "accessIPv6", "Value": ""}, {"Field": "addresses", "Value": "teuthology-test=10.50.50.10"}, {"Field": "config_drive", "Value": ""}, {"Field": "created", "Value": "2015-06-20T19:29:52Z"}, {"Field": "flavor", "Value": "m1.small (2)"}, {"Field": "hostId", "Value": "6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162"}, {"Field": "id", "Value": "81a6e000-7521-4bbf-b69f-024e9232a71d"}, {"Field": "image", "Value": "ubuntu-trusty-14.04 (62d1c667-f5bb-4754-8606-3479569fd5fe)"}, {"Field": "key_name", "Value": "teuthology"}, {"Field": "name", "Value": "the-re010"}, {"Field": "os-extended-volumes:volumes_attached", "Value": [{"id": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}]}, {"Field": "progress", "Value": 0}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "properties", "Value": ""}, {"Field": "security_groups", "Value": [{"name": "default"}]}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "updated", "Value": "2015-06-20T19:31:27Z"}, {"Field": "user_id", "Value": "0df7d9fa2d694b59821acd1d6c0e2291"}]

2015-06-20 19:32:23,835.835 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:32:24,818.818 ERROR:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 error ERROR: openstack No server with a name or ID of 'the-re010' exists.

2015-06-20 19:32:25,456.456 INFO:teuthology.lock:unlocked the-re010
2015-06-20 19:32:25,459.459 INFO:teuthology.run:Summary data:
{description: 'noop/{noop.yaml}', duration: 0.08653998374938965, owner: scheduled_ubuntu@teuthology,
success: true}

2015-06-20 19:32:25,460.460 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:32:25,460.460 INFO:teuthology.run:pass
2015-06-20 19:32:25,489.489 INFO:teuthology.worker:Success!
end
PASSEDsudo: unable to resolve host teuthology
* Restarting in-memory queueing server beanstalkd
...done.
2015-06-20 19:32:26,545.545 INFO:root:trying OpenStack cluster the-re
2015-06-20 19:32:26,546.546 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:32:26,546.546 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list
2015-06-20 19:32:28,116.116 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list output +--------------------------------------+------------+--------+--------------------------------------------------------------+
| ID | Name | Status | Networks |
+--------------------------------------+------------+--------+--------------------------------------------------------------+
| ecd351e4-3301-42c5-8126-f25be68155e9 | teuthology | ACTIVE | fsf-lan=10.0.3.31, 93.20.168.190; teuthology-test=10.50.50.2 |
+--------------------------------------+------------+--------+--------------------------------------------------------------+

2015-06-20 19:32:28,120.120 INFO:root:using OpenStack cluster the-re
2015-06-20 19:32:28,120.120 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
2015-06-20 19:32:32,180.180 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
output + cd ../paddles
+ sqlite3 dev.db
+ echo delete from nodes;
+ seq 10 19
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (10, 'the-re010', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (11, 'the-re011', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (12, 'the-re012', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (13, 'the-re013', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (14, 'the-re014', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (15, 'the-re015', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (16, 'the-re016', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (17, 'the-re017', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (18, 'the-re018', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (19, 'the-re019', 'openstack', 1, 0, 1);


teuthology/test/integration/openstack-integration.py::TestSchedule::test_schedule_noop sudo: unable to resolve host teuthology
* Restarting in-memory queueing server beanstalkd
...done.
2015-06-20 19:32:33,221.221 INFO:root:trying OpenStack cluster the-re
2015-06-20 19:32:33,222.222 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:32:33,222.222 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list
2015-06-20 19:32:34,236.236 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list output +--------------------------------------+------------+--------+--------------------------------------------------------------+
| ID | Name | Status | Networks |
+--------------------------------------+------------+--------+--------------------------------------------------------------+
| ecd351e4-3301-42c5-8126-f25be68155e9 | teuthology | ACTIVE | fsf-lan=10.0.3.31, 93.20.168.190; teuthology-test=10.50.50.2 |
+--------------------------------------+------------+--------+--------------------------------------------------------------+

2015-06-20 19:32:34,240.240 INFO:root:using OpenStack cluster the-re
2015-06-20 19:32:34,240.240 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
2015-06-20 19:32:37,683.683 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
output + cd ../paddles
+ sqlite3 dev.db
+ echo delete from nodes;
+ seq 10 19
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (10, 'the-re010', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (11, 'the-re011', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (12, 'the-re012', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (13, 'the-re013', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (14, 'the-re014', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (15, 'the-re015', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (16, 'the-re016', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (17, 'the-re017', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (18, 'the-re018', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (19, 'the-re019', 'openstack', 1, 0, 1);

Job scheduled with name fake and ID 1
2015-06-20 19:32:37,705.705 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:35:16,118.118 INFO:root:teuthology-worker --tube openstack -l /tmp/tmpcGRFkG/log --archive-dir /tmp/tmpcGRFkG/archive : stdout stderr 2015-06-20 19:32:37,892.892 INFO:teuthology.repo_utils:Fetching from upstream into /home/ubuntu/src/ceph-qa-suite_master
2015-06-20 19:32:39,411.411 INFO:teuthology.repo_utils:Resetting repo at /home/ubuntu/src/ceph-qa-suite_master to branch master
2015-06-20 19:32:39,428.428 INFO:teuthology.worker:Reserved job 1
2015-06-20 19:32:39,429.429 INFO:teuthology.worker:Config is: description: null
email: null
last_in_suite: false
machine_type: openstack
name: fake
os_type: ubuntu
os_version: '14.04'
owner: test@test.com
priority: 1000
roles:
- [mon.a, osd.0]
stop_worker: true
tasks:
- exec:
mon.a: [echo "Well done !"]
tube: openstack
verbose: true

2015-06-20 19:32:39,431.431 INFO:teuthology.repo_utils:Fetching from upstream into /home/ubuntu/src/ceph-qa-suite_master
2015-06-20 19:32:40,430.430 INFO:teuthology.repo_utils:Resetting repo at /home/ubuntu/src/ceph-qa-suite_master to branch master
2015-06-20 19:32:40,442.442 INFO:teuthology.worker:Creating archive dir /tmp/tmpcGRFkG/archive/fake/1
2015-06-20 19:32:40,442.442 INFO:teuthology.worker:Running job 1
2015-06-20 19:32:40,450.450 INFO:teuthology.worker:Job archive: /tmp/tmpcGRFkG/archive/fake/1
2015-06-20 19:32:40,450.450 INFO:teuthology.worker:Job PID: 32499
2015-06-20 19:32:40,450.450 INFO:teuthology.worker:Running without watchdog
2015-06-20 19:32:40,742.742 DEBUG:teuthology.run:Teuthology command: teuthology /tmp/teuthology-worker.HLh6W5.tmp -- --verbose --lock --name fake --block --owner test@test.com --archive /tmp/tmpcGRFkG/archive/fake/1
2015-06-20 19:32:40,748.748 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:32:40,750.750 DEBUG:teuthology.run:Config:
archive_path: /tmp/tmpcGRFkG/archive/fake/1
description: null
email: null
job_id: '1'
last_in_suite: false
machine_type: openstack
name: fake
os_type: ubuntu
os_version: '14.04'
owner: test@test.com
priority: 1000
roles:
- - mon.a
- osd.0
stop_worker: true
suite_path: /home/ubuntu/src/ceph-qa-suite_master
tasks:
- exec:
mon.a:
- echo "Well done !"
teuthology_branch: master
tube: openstack
verbose: true
worker_log: /tmp/tmpcGRFkG/log/worker.openstack.32478
2015-06-20 19:32:40,750.750 INFO:teuthology.run:suite_path is set to /home/ubuntu/src/ceph-qa-suite_master; will attempt to use it
2015-06-20 19:32:40,750.750 INFO:teuthology.run:Found tasks at /home/ubuntu/src/ceph-qa-suite_master/tasks
2015-06-20 19:32:40,755.755 INFO:teuthology.run_tasks:Running task internal.check_packages...
2015-06-20 19:32:40,755.755 INFO:teuthology.task.internal:Checking packages...
2015-06-20 19:32:40,755.755 INFO:teuthology.task.internal:Checking packages skipped, missing os_type 'ubuntu' or ceph hash 'None'
2015-06-20 19:32:40,755.755 INFO:teuthology.run_tasks:Running task internal.lock_machines...
2015-06-20 19:32:40,756.756 INFO:teuthology.task.internal:Locking machines...
2015-06-20 19:32:40,756.756 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:32:40,756.756 DEBUG:teuthology.lock:list_locks: http://localhost:8080/nodes/?count=6&locked=0&up=1&machine_type=openstack
2015-06-20 19:32:40,766.766 DEBUG:teuthology.lock:lock_many request: {'count': 1, 'locked_by': 'test@test.com', 'description': '/tmp/tmpcGRFkG/archive/fake/1', 'machine_type': 'openstack'}
2015-06-20 19:32:41,078.078 DEBUG:teuthology.lock:locked the-re010
2015-06-20 19:32:41,110.110 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:32:41,111.111 DEBUG:teuthology.provision:OpenStack:destroy
2015-06-20 19:32:41,111.111 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:32:42,155.155 ERROR:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 error ERROR: openstack No server with a name or ID of 'the-re010' exists.

2015-06-20 19:32:42,155.155 DEBUG:teuthology.provision:OpenStack:create
2015-06-20 19:32:42,155.155 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack network show -f json teuthology-test
2015-06-20 19:32:43,130.130 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack network show -f json teuthology-test output [{"Field": "id", "Value": "582950be-f33c-4375-8f8e-14606143e6d7"}, {"Field": "name", "Value": "teuthology-test"}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "router_type", "Value": "Internal"}, {"Field": "shared", "Value": false}, {"Field": "state", "Value": "UP"}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "subnets", "Value": "5ecec13c-df5b-42f5-9f54-2bf1c2d95d9d"}]

2015-06-20 19:32:43,130.130 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack flavor list -f json
2015-06-20 19:32:44,030.030 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack flavor list -f json output [{"ID": "01912b08-dfe0-480e-9b38-5ba8c310e08f", "Name": "2cpu-3G", "RAM": 3192, "Disk": 10, "Ephemeral": 0, "VCPUs": 2, "Is Public": true}, {"ID": "1", "Name": "m1.tiny", "RAM": 512, "Disk": 1, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "2", "Name": "m1.small", "RAM": 1024, "Disk": 10, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "24f09411-ab77-468c-b42c-93d7168f87f6", "Name": "1cpu-256M", "RAM": 256, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "3", "Name": "m1.medium", "RAM": 3192, "Disk": 10, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "4", "Name": "m1.large", "RAM": 8192, "Disk": 80, "Ephemeral": 0, "VCPUs": 4, "Is Public": true}, {"ID": "4ed21e7a-52a6-4b0f-9754-74ae925109b6", "Name": "1cpu-512M", "RAM": 512, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "5", "Name": "m1.xlarge", "RAM": 16384, "Disk": 160, "Ephemeral": 0, "VCPUs": 8, "Is Public": true}, {"ID": "b1bbe2bd-c3bd-45a4-9a3e-704547ab0c69", "Name": "2cpu-4G", "RAM": 4096, "Disk": 0, "Ephemeral": 0, "VCPUs": 2, "Is Public": true}, {"ID": "c16e3f8b-c9ce-442b-8cfa-a23aeff6928c", "Name": "6cpu-8G", "RAM": 8192, "Disk": 0, "Ephemeral": 0, "VCPUs": 6, "Is Public": true}, {"ID": "c7798fdc-a3b0-4512-8c21-43227e987801", "Name": "1cpu-1G", "RAM": 1024, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "f52f848c-6efc-43e7-96d0-d3b04686881b", "Name": "1cpu-2G", "RAM": 2048, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "fe0a54e0-3552-479d-9374-1b131486a0de", "Name": "1cpu-4G", "RAM": 4096, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}]

2015-06-20 19:32:44,031.031 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack volume show -f json the-re010-0
2015-06-20 19:32:45,157.157 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack volume show -f json the-re010-0 output [{"Field": "attachments", "Value": []}, {"Field": "availability_zone", "Value": "ovh"}, {"Field": "bootable", "Value": "false"}, {"Field": "created_at", "Value": "2015-06-14T16:57:58.000000"}, {"Field": "display_description", "Value": null}, {"Field": "display_name", "Value": "the-re010-0"}, {"Field": "id", "Value": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}, {"Field": "properties", "Value": "readonly='False'"}, {"Field": "size", "Value": 1}, {"Field": "snapshot_id", "Value": null}, {"Field": "source_volid", "Value": null}, {"Field": "status", "Value": "available"}, {"Field": "type", "Value": "ovh"}]

2015-06-20 19:32:45,157.157 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server create --availability-zone ovh --block-device-mapping /dev/vdb=ab5b1622-2db5-4e95-80c4-9384f0e43bdd --image ubuntu-trusty-14.04 --flavor m1.small --key-name teuthology --user-data /tmp/tmp15ollX --nic net-id=582950be-f33c-4375-8f8e-14606143e6d7,v4-fixed-ip=10.50.50.10 --wait the-re010
2015-06-20 19:32:58,220.220 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server create --availability-zone ovh --block-device-mapping /dev/vdb=ab5b1622-2db5-4e95-80c4-9384f0e43bdd --image ubuntu-trusty-14.04 --flavor m1.small --key-name teuthology --user-data /tmp/tmp15ollX --nic net-id=582950be-f33c-4375-8f8e-14606143e6d7,v4-fixed-ip=10.50.50.10 --wait the-re010 output
+--------------------------------------+------------------------------------------------------------+
| Field | Value |
+--------------------------------------+------------------------------------------------------------+
| OS-DCF:diskConfig | MANUAL |
| OS-EXT-AZ:availability_zone | ovh |
| OS-EXT-STS:power_state | 1 |
| OS-EXT-STS:task_state | None |
| OS-EXT-STS:vm_state | active |
| OS-SRV-USG:launched_at | 2015-06-20T19:32:53.000000 |
| OS-SRV-USG:terminated_at | None |
| accessIPv4 | |
| accessIPv6 | |
| addresses | teuthology-test=10.50.50.10 |
| adminPass | KoSpev5F5HgX |
| config_drive | |
| created | 2015-06-20T19:32:47Z |
| flavor | m1.small (2) |
| hostId | 6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162 |
| id | 4f226213-15f4-4d98-ae55-3212f251684e |
| image | ubuntu-trusty-14.04 (62d1c667-f5bb-4754-8606-3479569fd5fe) |
| key_name | teuthology |
| name | the-re010 |
| os-extended-volumes:volumes_attached | [{u'id': u'ab5b1622-2db5-4e95-80c4-9384f0e43bdd'}] |
| progress | 0 |
| project_id | a5fa44393fbf4a1fa006d83b996595ef |
| properties | |
| security_groups | [{u'name': u'default'}] |
| status | ACTIVE |
| updated | 2015-06-20T19:32:53Z |
| user_id | 0df7d9fa2d694b59821acd1d6c0e2291 |
+--------------------------------------+------------------------------------------------------------+

2015-06-20 19:33:59,351.351 DEBUG:teuthology.provision:cloud_init_wait
2015-06-20 19:33:59,546.546 DEBUG:teuthology.provision:cloud_init_wait grep 'The system is finally up' /var/log/cloud-init.log
2015-06-20 19:34:00,790.790 DEBUG:teuthology.provision:cloud_init_wait stdout grep 'The system is finally up' /var/log/cloud-init.log Jun 20 19:33:37 the-re010 [CLOUDINIT] util.py[DEBUG]: The system is finally up, after 42.92 seconds

2015-06-20 19:34:00,790.790 DEBUG:teuthology.provision:cloud_init_wait stderr grep 'The system is finally up' /var/log/cloud-init.log
2015-06-20 19:34:00,822.822 INFO:teuthology.task.internal:Waiting for virtual machines to come up
2015-06-20 19:34:10,864.864 INFO:teuthology.task.internal:virtual machine is still unavailable
2015-06-20 19:34:10,865.865 DEBUG:teuthology.lock:list_locks: http://localhost:8080/nodes/
2015-06-20 19:34:10,901.901 INFO:teuthology.lock:Checking the-re010
2015-06-20 19:34:10,901.901 INFO:teuthology.lock:New key found. Updating...
2015-06-20 19:34:11,171.171 INFO:teuthology.task.internal:Locked targets:
the-re010: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCqm+DL8GnCHbZnRWCPSR6dpuGIiDJwlIhULpPz8rPUauUyyeXVpc/KxpMZQINTzUlb7DxxmhcliJS7e+1f+4mo6i37ypfgS0EpYEnkRuPOVBag0Fwqr21AkzqXaRIGeYFhVdi1dwj1RqdMezNNnqQOAUtaMAlhbkmBnxWFqCw0W09ZyNoH37sRDgEFRIZGg8D9GbYIdYB/YtMPe/Wz8amQG/IuuH7Fg261CUsXwfZfJo6+R9iQBaokY9NrZ8hVrtcKtaHkKgM+oWtZhbAOl79Cu6i3t9nltPMWatXuZ0JdWd/tJ+ZubBs7j0QL6IEdEeLxGnNKGHPsp6AeEQsuVlAZ
2015-06-20 19:34:11,171.171 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:34:11,171.171 INFO:teuthology.run_tasks:Running task internal.save_config...
2015-06-20 19:34:11,172.172 INFO:teuthology.task.internal:Saving configuration
2015-06-20 19:34:11,176.176 INFO:teuthology.run_tasks:Running task internal.check_lock...
2015-06-20 19:34:11,176.176 INFO:teuthology.task.internal:Checking locks...
2015-06-20 19:34:11,188.188 DEBUG:teuthology.task.internal:machine status is {u'is_vm': True, u'locked': True, u'locked_since': u'2015-06-20 19:32:40.773305', u'locked_by': u'test@test.com', u'up': True, u'mac_address': None, u'name': u'the-re010', u'os_version': None, u'machine_type': u'openstack', u'vm_host': None, u'os_type': None, u'arch': None, u'ssh_pub_key': u'ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCqm+DL8GnCHbZnRWCPSR6dpuGIiDJwlIhULpPz8rPUauUyyeXVpc/KxpMZQINTzUlb7DxxmhcliJS7e+1f+4mo6i37ypfgS0EpYEnkRuPOVBag0Fwqr21AkzqXaRIGeYFhVdi1dwj1RqdMezNNnqQOAUtaMAlhbkmBnxWFqCw0W09ZyNoH37sRDgEFRIZGg8D9GbYIdYB/YtMPe/Wz8amQG/IuuH7Fg261CUsXwfZfJo6+R9iQBaokY9NrZ8hVrtcKtaHkKgM+oWtZhbAOl79Cu6i3t9nltPMWatXuZ0JdWd/tJ+ZubBs7j0QL6IEdEeLxGnNKGHPsp6AeEQsuVlAZ', u'description': u'/tmp/tmpcGRFkG/archive/fake/1'}
2015-06-20 19:34:11,188.188 INFO:teuthology.run_tasks:Running task internal.add_remotes...
2015-06-20 19:34:11,188.188 INFO:teuthology.task.internal:roles: the-re010 - ['mon.a', 'osd.0']
2015-06-20 19:34:11,189.189 INFO:teuthology.run_tasks:Running task internal.connect...
2015-06-20 19:34:11,189.189 INFO:teuthology.task.internal:Opening connections...
2015-06-20 19:34:11,189.189 DEBUG:teuthology.task.internal:connecting to the-re010
2015-06-20 19:34:11,189.189 INFO:teuthology.orchestra.connection:{'username': None, 'hostname': u'the-re010', 'timeout': 60}
2015-06-20 19:34:11,348.348 INFO:teuthology.run_tasks:Running task internal.push_inventory...
2015-06-20 19:34:11,349.349 INFO:teuthology.orchestra.run.the-re010:Running: 'hostname --fqdn'
2015-06-20 19:34:11,559.559 INFO:teuthology.orchestra.run.the-re010:Running: 'uname -m'
2015-06-20 19:34:11,632.632 INFO:teuthology.orchestra.run.the-re010:Running: "python -c 'import platform; print platform.linux_distribution()'"
2015-06-20 19:34:11,722.722 INFO:teuthology.lock:Updating the-re010 on lock server
2015-06-20 19:34:12,115.115 INFO:teuthology.run_tasks:Running task internal.serialize_remote_roles...
2015-06-20 19:34:12,120.120 INFO:teuthology.run_tasks:Running task internal.check_conflict...
2015-06-20 19:34:12,120.120 INFO:teuthology.task.internal:Checking for old test directory...
2015-06-20 19:34:12,121.121 INFO:teuthology.orchestra.run.the-re010:Running: "test '!' -e /home/ubuntu/cephtest"
2015-06-20 19:34:12,126.126 INFO:teuthology.run_tasks:Running task internal.check_ceph_data...
2015-06-20 19:34:12,127.127 INFO:teuthology.task.internal:Checking for old /var/lib/ceph...
2015-06-20 19:34:12,127.127 INFO:teuthology.orchestra.run.the-re010:Running: "test '!' -e /var/lib/ceph"
2015-06-20 19:34:12,196.196 INFO:teuthology.run_tasks:Running task internal.vm_setup...
2015-06-20 19:34:12,197.197 INFO:teuthology.task.internal:vm_setup ctx = {'': True, 'suite_path': None, 'verbose': True, 'name': 'fake', 'cluster': Cluster(remotes=[[Remote(name=u'the-re010'), ['mon.a', 'osd.0']]]), 'lock': True, 'description': None, 'summary': {'owner': 'test@test.com', 'success': True}, 'os_version': None, 'teuthology_config': {'lock_server': 'http://localhost:8080/', 'queue_port': 11300, 'lab_domain': 'openstacklocal', 'openstack': {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}, 'teuthology_path': '.', 'queue_host': 'localhost', 'canonicalize_hostname': False, 'results_server': None}, 'version': False, 'machine_type': 'openstack', 'owner': 'test@test.com', 'os_type': None, 'config': {'archive_path': '/tmp/tmpcGRFkG/archive/fake/1', 'teuthology_branch': 'master', 'tasks': [{'internal.check_packages': None}, {'internal.lock_machines': (1, 'openstack')}, {'internal.save_config': None}, {'internal.check_lock': None}, {'internal.add_remotes': None}, {'internal.connect': None}, {'internal.push_inventory': None}, {'internal.serialize_remote_roles': None}, {'internal.check_conflict': None}, {'internal.check_ceph_data': None}, {'internal.vm_setup': None}, {'internal.base': None}, {'internal.archive': None}, {'internal.coredump': None}, {'internal.sudo': None}, {'internal.syslog': None}, {'internal.timer': None}, {'exec': {'mon.a': ['echo "Well done !"']}}], 'suite_path': '/home/ubuntu/src/ceph-qa-suite_master', 'description': None, 'stop_worker': True, 'tube': 'openstack', 'worker_log': '/tmp/tmpcGRFkG/log/worker.openstack.32478', 'job_id': '1', 'targets': {u'the-re010': u'ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCqm+DL8GnCHbZnRWCPSR6dpuGIiDJwlIhULpPz8rPUauUyyeXVpc/KxpMZQINTzUlb7DxxmhcliJS7e+1f+4mo6i37ypfgS0EpYEnkRuPOVBag0Fwqr21AkzqXaRIGeYFhVdi1dwj1RqdMezNNnqQOAUtaMAlhbkmBnxWFqCw0W09ZyNoH37sRDgEFRIZGg8D9GbYIdYB/YtMPe/Wz8amQG/IuuH7Fg261CUsXwfZfJo6+R9iQBaokY9NrZ8hVrtcKtaHkKgM+oWtZhbAOl79Cu6i3t9nltPMWatXuZ0JdWd/tJ+ZubBs7j0QL6IEdEeLxGnNKGHPsp6AeEQsuVlAZ'}, 'name': 'fake', 'priority': 1000, 'os_version': '14.04', 'last_in_suite': False, 'roles': [['mon.a', 'osd.0']], 'machine_type': 'openstack', 'owner': 'test@test.com', 'os_type': 'ubuntu', 'email': None, 'verbose': True}, 'archive': '/tmp/tmpcGRFkG/archive/fake/1', 'block': True, 'help': False} config = None
2015-06-20 19:34:12,211.211 INFO:teuthology.orchestra.run.the-re010:Running: 'test -e /ceph-qa-ready'
2015-06-20 19:34:12,247.247 INFO:teuthology.task.internal:edit /etc/sudoers on the-re010
@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
@ WARNING: REMOTE HOST IDENTIFICATION HAS CHANGED! @
@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
IT IS POSSIBLE THAT SOMEONE IS DOING SOMETHING NASTY!
Someone could be eavesdropping on you right now (man-in-the-middle attack)!
It is also possible that a host key has just been changed.
The fingerprint for the ECDSA key sent by the remote host is
49:b4:15:e6:cc:8d:64:ab:f4:2a:03:d7:fa:97:b5:d0.
Please contact your system administrator.
Add correct host key in /home/ubuntu/.ssh/known_hosts to get rid of this message.
Offending ECDSA key in /home/ubuntu/.ssh/known_hosts:1
remove with: ssh-keygen -f "/home/ubuntu/.ssh/known_hosts" -R the-re010
Password authentication is disabled to avoid man-in-the-middle attacks.
Keyboard-interactive authentication is disabled to avoid man-in-the-middle attacks.
Connection to the-re010 closed.
2015-06-20 19:34:13,001.001 INFO:teuthology.run_tasks:Running task internal.base...
2015-06-20 19:34:13,001.001 INFO:teuthology.task.internal:Creating test directory...
2015-06-20 19:34:13,002.002 INFO:teuthology.orchestra.run.the-re010:Running: 'mkdir -p -m0755 -- /home/ubuntu/cephtest'
2015-06-20 19:34:13,013.013 INFO:teuthology.run_tasks:Running task internal.archive...
2015-06-20 19:34:13,013.013 INFO:teuthology.task.internal:Creating archive directory...
2015-06-20 19:34:13,013.013 INFO:teuthology.orchestra.run.the-re010:Running: 'install -d -m0755 -- /home/ubuntu/cephtest/archive'
2015-06-20 19:34:13,093.093 INFO:teuthology.run_tasks:Running task internal.coredump...
2015-06-20 19:34:13,094.094 INFO:teuthology.task.internal:Enabling coredump saving...
2015-06-20 19:34:13,094.094 INFO:teuthology.orchestra.run.the-re010:Running: 'install -d -m0755 -- /home/ubuntu/cephtest/archive/coredump && sudo sysctl -w kernel.core_pattern=/home/ubuntu/cephtest/archive/coredump/%t.%p.core'
2015-06-20 19:34:13,200.200 INFO:teuthology.orchestra.run.the-re010.stdout:kernel.core_pattern = /home/ubuntu/cephtest/archive/coredump/%t.%p.core
2015-06-20 19:34:13,202.202 INFO:teuthology.run_tasks:Running task internal.sudo...
2015-06-20 19:34:13,203.203 INFO:teuthology.task.internal:Configuring sudo...
2015-06-20 19:34:13,203.203 INFO:teuthology.orchestra.run.the-re010:Running: "sudo sed -i.orig.teuthology -e 's/^\\([^#]*\\) \\(requiretty\\)/\\1 !\\2/g' -e 's/^\\([^#]*\\) !\\(visiblepw\\)/\\1 \\2/g' /etc/sudoers"
2015-06-20 19:34:13,279.279 INFO:teuthology.run_tasks:Running task internal.syslog...
2015-06-20 19:34:13,279.279 INFO:teuthology.task.internal:Starting syslog monitoring...
2015-06-20 19:34:13,280.280 INFO:teuthology.orchestra.run.the-re010:Running: 'mkdir -p -m0755 -- /home/ubuntu/cephtest/archive/syslog'
2015-06-20 19:34:13,352.352 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo python -c \'import shutil, sys; shutil.copyfileobj(sys.stdin, file(sys.argv[1], "wb"))\' /etc/rsyslog.d/80-cephtest.conf'
2015-06-20 19:34:13,464.464 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo service rsyslog restart'
2015-06-20 19:34:13,570.570 INFO:teuthology.orchestra.run.the-re010.stdout:rsyslog stop/waiting
2015-06-20 19:34:13,591.591 INFO:teuthology.orchestra.run.the-re010.stdout:rsyslog start/running, process 1567
2015-06-20 19:34:13,592.592 INFO:teuthology.run_tasks:Running task internal.timer...
2015-06-20 19:34:13,592.592 INFO:teuthology.task.internal:Starting timer...
2015-06-20 19:34:13,592.592 INFO:teuthology.run_tasks:Running task exec...
2015-06-20 19:34:13,593.593 INFO:teuthology.task.exec:Executing custom commands...
2015-06-20 19:34:13,593.593 INFO:teuthology.task.exec:Running commands on role mon.a host the-re010
2015-06-20 19:34:13,593.593 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo TESTDIR=/home/ubuntu/cephtest bash -c \'echo "Well done !"\''
2015-06-20 19:34:13,673.673 INFO:teuthology.orchestra.run.the-re010.stdout:Well done !
2015-06-20 19:34:13,675.675 DEBUG:teuthology.run_tasks:Unwinding manager internal.timer
2015-06-20 19:34:13,675.675 INFO:teuthology.task.internal:Duration was 0.082619 seconds
2015-06-20 19:34:13,675.675 DEBUG:teuthology.run_tasks:Unwinding manager internal.syslog
2015-06-20 19:34:13,676.676 INFO:teuthology.task.internal:Shutting down syslog monitoring...
2015-06-20 19:34:13,676.676 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo rm -f -- /etc/rsyslog.d/80-cephtest.conf && sudo service rsyslog restart'
2015-06-20 19:34:13,777.777 INFO:teuthology.orchestra.run.the-re010.stdout:rsyslog stop/waiting
2015-06-20 19:34:13,800.800 INFO:teuthology.orchestra.run.the-re010.stdout:rsyslog start/running, process 1598
2015-06-20 19:34:13,800.800 INFO:teuthology.task.internal:Checking logs for errors...
2015-06-20 19:34:13,800.800 DEBUG:teuthology.task.internal:Checking the-re010
2015-06-20 19:34:13,801.801 INFO:teuthology.orchestra.run.the-re010:Running: "egrep --binary-files=text '\\bBUG\\b|\\bINFO\\b|\\bDEADLOCK\\b' /home/ubuntu/cephtest/archive/syslog/*.log | grep -v 'task .* blocked for more than .* seconds' | grep -v 'lockdep is turned off' | grep -v 'trying to register non-static key' | grep -v 'DEBUG: fsize' | grep -v CRON | grep -v 'BUG: bad unlock balance detected' | grep -v 'inconsistent lock state' | grep -v '*** DEADLOCK ***' | grep -v 'INFO: possible irq lock inversion dependency detected' | grep -v 'INFO: NMI handler (perf_event_nmi_handler) took too long to run' | grep -v 'INFO: recovery required on readonly' | head -n 1"
2015-06-20 19:34:13,882.882 INFO:teuthology.orchestra.run.the-re010.stderr:egrep: /home/ubuntu/cephtest/archive/syslog/*.log: No such file or directory
2015-06-20 19:34:13,884.884 INFO:teuthology.task.internal:Compressing syslogs...
2015-06-20 19:34:13,884.884 INFO:teuthology.orchestra.run.the-re010:Running: "find /home/ubuntu/cephtest/archive/syslog -name '*.log' -print0 | sudo xargs -0 --no-run-if-empty -- gzip --"
2015-06-20 19:34:13,968.968 DEBUG:teuthology.run_tasks:Unwinding manager internal.sudo
2015-06-20 19:34:13,968.968 INFO:teuthology.task.internal:Restoring /etc/sudoers...
2015-06-20 19:34:13,968.968 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo mv -f /etc/sudoers.orig.teuthology /etc/sudoers'
2015-06-20 19:34:14,045.045 DEBUG:teuthology.run_tasks:Unwinding manager internal.coredump
2015-06-20 19:34:14,046.046 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo sysctl -w kernel.core_pattern=core && rmdir --ignore-fail-on-non-empty -- /home/ubuntu/cephtest/archive/coredump'
2015-06-20 19:34:14,124.124 INFO:teuthology.orchestra.run.the-re010.stdout:kernel.core_pattern = core
2015-06-20 19:34:14,139.139 INFO:teuthology.orchestra.run.the-re010:Running: "if test '!' -e /home/ubuntu/cephtest/archive/coredump ; then echo OK ; fi"
2015-06-20 19:34:14,210.210 DEBUG:teuthology.run_tasks:Unwinding manager internal.archive
2015-06-20 19:34:14,211.211 INFO:teuthology.task.internal:Transferring archived files...
2015-06-20 19:34:14,212.212 DEBUG:teuthology.misc:Transferring archived files from the-re010:/home/ubuntu/cephtest/archive to /tmp/tmpcGRFkG/archive/fake/1/remote/the-re010
2015-06-20 19:34:14,213.213 INFO:teuthology.orchestra.run.the-re010:Running: "python -c 'import os; import tempfile; import sys;(fd,fname) = tempfile.mkstemp();os.close(fd);sys.stdout.write(fname.rstrip());sys.stdout.flush()'"
2015-06-20 19:34:14,301.301 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo tar cz -f /tmp/tmpBSc1Gq -C /home/ubuntu/cephtest/archive -- .'
2015-06-20 19:34:14,431.431 INFO:teuthology.orchestra.run.the-re010:Running: 'sudo chmod 0666 /tmp/tmpBSc1Gq'
2015-06-20 19:34:14,541.541 INFO:teuthology.orchestra.run.the-re010:Running: 'rm -fr /tmp/tmpBSc1Gq'
2015-06-20 19:34:14,551.551 INFO:teuthology.task.internal:Removing archive directory...
2015-06-20 19:34:14,551.551 INFO:teuthology.orchestra.run.the-re010:Running: 'rm -rf -- /home/ubuntu/cephtest/archive'
2015-06-20 19:34:14,625.625 DEBUG:teuthology.run_tasks:Unwinding manager internal.base
2015-06-20 19:34:14,625.625 INFO:teuthology.task.internal:Tidying up after the test...
2015-06-20 19:34:14,626.626 INFO:teuthology.orchestra.run.the-re010:Running: 'rmdir -- /home/ubuntu/cephtest'
2015-06-20 19:34:14,698.698 DEBUG:teuthology.run_tasks:Unwinding manager internal.lock_machines
2015-06-20 19:34:14,699.699 INFO:teuthology.task.internal:Unlocking machines...
2015-06-20 19:34:14,712.712 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:34:14,712.712 DEBUG:teuthology.provision:OpenStack:destroy
2015-06-20 19:34:14,713.713 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:34:16,272.272 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 output [{"Field": "OS-DCF:diskConfig", "Value": "MANUAL"}, {"Field": "OS-EXT-AZ:availability_zone", "Value": "ovh"}, {"Field": "OS-EXT-STS:power_state", "Value": 1}, {"Field": "OS-EXT-STS:task_state", "Value": null}, {"Field": "OS-EXT-STS:vm_state", "Value": "active"}, {"Field": "OS-SRV-USG:launched_at", "Value": "2015-06-20T19:32:53.000000"}, {"Field": "OS-SRV-USG:terminated_at", "Value": null}, {"Field": "accessIPv4", "Value": ""}, {"Field": "accessIPv6", "Value": ""}, {"Field": "addresses", "Value": "teuthology-test=10.50.50.10"}, {"Field": "config_drive", "Value": ""}, {"Field": "created", "Value": "2015-06-20T19:32:47Z"}, {"Field": "flavor", "Value": "m1.small (2)"}, {"Field": "hostId", "Value": "6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162"}, {"Field": "id", "Value": "4f226213-15f4-4d98-ae55-3212f251684e"}, {"Field": "image", "Value": "ubuntu-trusty-14.04 (62d1c667-f5bb-4754-8606-3479569fd5fe)"}, {"Field": "key_name", "Value": "teuthology"}, {"Field": "name", "Value": "the-re010"}, {"Field": "os-extended-volumes:volumes_attached", "Value": [{"id": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}]}, {"Field": "progress", "Value": 0}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "properties", "Value": ""}, {"Field": "security_groups", "Value": [{"name": "default"}]}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "updated", "Value": "2015-06-20T19:32:53Z"}, {"Field": "user_id", "Value": "0df7d9fa2d694b59821acd1d6c0e2291"}]

2015-06-20 19:34:16,272.272 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server delete the-re010
2015-06-20 19:34:17,700.700 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server delete the-re010 output
2015-06-20 19:34:17,700.700 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:34:19,230.230 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 output [{"Field": "OS-DCF:diskConfig", "Value": "MANUAL"}, {"Field": "OS-EXT-AZ:availability_zone", "Value": "ovh"}, {"Field": "OS-EXT-STS:power_state", "Value": 1}, {"Field": "OS-EXT-STS:task_state", "Value": "deleting"}, {"Field": "OS-EXT-STS:vm_state", "Value": "active"}, {"Field": "OS-SRV-USG:launched_at", "Value": "2015-06-20T19:32:53.000000"}, {"Field": "OS-SRV-USG:terminated_at", "Value": null}, {"Field": "accessIPv4", "Value": ""}, {"Field": "accessIPv6", "Value": ""}, {"Field": "addresses", "Value": "teuthology-test=10.50.50.10"}, {"Field": "config_drive", "Value": ""}, {"Field": "created", "Value": "2015-06-20T19:32:47Z"}, {"Field": "flavor", "Value": "m1.small (2)"}, {"Field": "hostId", "Value": "6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162"}, {"Field": "id", "Value": "4f226213-15f4-4d98-ae55-3212f251684e"}, {"Field": "image", "Value": "ubuntu-trusty-14.04 (62d1c667-f5bb-4754-8606-3479569fd5fe)"}, {"Field": "key_name", "Value": "teuthology"}, {"Field": "name", "Value": "the-re010"}, {"Field": "os-extended-volumes:volumes_attached", "Value": [{"id": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}]}, {"Field": "progress", "Value": 0}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "properties", "Value": ""}, {"Field": "security_groups", "Value": [{"name": "default"}]}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "updated", "Value": "2015-06-20T19:34:17Z"}, {"Field": "user_id", "Value": "0df7d9fa2d694b59821acd1d6c0e2291"}]

2015-06-20 19:35:14,713.713 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:35:15,777.777 ERROR:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 error ERROR: openstack No server with a name or ID of 'the-re010' exists.

2015-06-20 19:35:16,075.075 INFO:teuthology.lock:unlocked the-re010
2015-06-20 19:35:16,076.076 INFO:teuthology.run:Summary data:
{duration: 0.08261895179748535, owner: test@test.com, success: true}

2015-06-20 19:35:16,076.076 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:35:16,076.076 INFO:teuthology.run:pass
2015-06-20 19:35:16,101.101 INFO:teuthology.worker:Success!
end
PASSED
teuthology/test/integration/openstack-integration.py::TestSchedule::test_schedule_stop_worker Job scheduled with name fake and ID 2
2015-06-20 19:35:16,136.136 WARNING:teuthology.report:No result_server in config; not reporting results
2015-06-20 19:35:18,306.306 INFO:root:teuthology-worker --tube openstack -l /tmp/tmpGBCInh/log --archive-dir /tmp/tmpGBCInh/archive : stdout stderr 2015-06-20 19:35:16,349.349 INFO:teuthology.repo_utils:Fetching from upstream into /home/ubuntu/src/ceph-qa-suite_master
2015-06-20 19:35:17,346.346 INFO:teuthology.repo_utils:Resetting repo at /home/ubuntu/src/ceph-qa-suite_master to branch master
2015-06-20 19:35:17,360.360 INFO:teuthology.worker:Reserved job 2
2015-06-20 19:35:17,360.360 INFO:teuthology.worker:Config is: {description: null, email: null, last_in_suite: false, machine_type: openstack, name: fake,
owner: test@test.com, priority: 1000, stop_worker: true, tube: openstack, verbose: true}

2015-06-20 19:35:17,362.362 INFO:teuthology.repo_utils:Fetching from upstream into /home/ubuntu/src/ceph-qa-suite_master
2015-06-20 19:35:18,265.265 INFO:teuthology.repo_utils:Resetting repo at /home/ubuntu/src/ceph-qa-suite_master to branch master
2015-06-20 19:35:18,277.277 INFO:teuthology.worker:Creating archive dir /tmp/tmpGBCInh/archive/fake/2
end
PASSEDsudo: unable to resolve host teuthology
* Restarting in-memory queueing server beanstalkd
...done.
2015-06-20 19:35:19,333.333 INFO:root:trying OpenStack cluster the-re
2015-06-20 19:35:19,333.333 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:35:19,336.336 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list
2015-06-20 19:35:20,214.214 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list output +--------------------------------------+------------+--------+--------------------------------------------------------------+
| ID | Name | Status | Networks |
+--------------------------------------+------------+--------+--------------------------------------------------------------+
| ecd351e4-3301-42c5-8126-f25be68155e9 | teuthology | ACTIVE | fsf-lan=10.0.3.31, 93.20.168.190; teuthology-test=10.50.50.2 |
+--------------------------------------+------------+--------+--------------------------------------------------------------+

2015-06-20 19:35:20,216.216 INFO:root:using OpenStack cluster the-re
2015-06-20 19:35:20,216.216 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
2015-06-20 19:35:23,874.874 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
output + cd ../paddles
+ sqlite3 dev.db
+ echo delete from nodes;
+ seq 10 19
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (10, 'the-re010', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (11, 'the-re011', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (12, 'the-re012', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (13, 'the-re013', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (14, 'the-re014', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (15, 'the-re015', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (16, 'the-re016', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (17, 'the-re017', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (18, 'the-re018', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (19, 'the-re019', 'openstack', 1, 0, 1);


teuthology/test/integration/openstack-integration.py::TestLock::test_create_destroy sudo: unable to resolve host teuthology
* Restarting in-memory queueing server beanstalkd
...done.
2015-06-20 19:35:24,901.901 INFO:root:trying OpenStack cluster the-re
2015-06-20 19:35:24,902.902 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:35:24,902.902 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list
2015-06-20 19:35:25,797.797 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list output +--------------------------------------+------------+--------+--------------------------------------------------------------+
| ID | Name | Status | Networks |
+--------------------------------------+------------+--------+--------------------------------------------------------------+
| ecd351e4-3301-42c5-8126-f25be68155e9 | teuthology | ACTIVE | fsf-lan=10.0.3.31, 93.20.168.190; teuthology-test=10.50.50.2 |
+--------------------------------------+------------+--------+--------------------------------------------------------------+

2015-06-20 19:35:25,800.800 INFO:root:using OpenStack cluster the-re
2015-06-20 19:35:25,800.800 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
2015-06-20 19:35:31,069.069 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
output + cd ../paddles
+ sqlite3 dev.db
+ echo delete from nodes;
+ seq 10 19
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (10, 'the-re010', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (11, 'the-re011', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (12, 'the-re012', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (13, 'the-re013', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (14, 'the-re014', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (15, 'the-re015', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (16, 'the-re016', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (17, 'the-re017', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (18, 'the-re018', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (19, 'the-re019', 'openstack', 1, 0, 1);

2015-06-20 19:35:32,032.032 DEBUG:teuthology.lock:locked the-re010 as ubuntu@teuthology
2015-06-20 19:35:32,056.056 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:35:32,086.086 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:35:32,722.722 INFO:teuthology.lock:unlocked the-re010
PASSED
teuthology/test/integration/openstack-integration.py::TestLock::test_list 2015-06-20 19:35:32,734.734 DEBUG:teuthology.lock:list_locks: http://localhost:8080/nodes/
2015-06-20 19:35:32,751.751 INFO:root:--list --all : [
{
"is_vm": true,
"locked": false,
"locked_since": null,
"locked_by": null,
"up": true,
"mac_address": null,
"name": "the-re010",
"os_version": null,
"machine_type": "openstack",
"vm_host": null,
"os_type": null,
"arch": null,
"ssh_pub_key": null,
"description": null
},
{
"is_vm": true,
"locked": false,
"locked_since": null,
"locked_by": null,
"up": true,
"mac_address": null,
"name": "the-re011",
"os_version": null,
"machine_type": "openstack",
"vm_host": null,
"os_type": null,
"arch": null,
"ssh_pub_key": null,
"description": null
},
{
"is_vm": true,
"locked": false,
"locked_since": null,
"locked_by": null,
"up": true,
"mac_address": null,
"name": "the-re012",
"os_version": null,
"machine_type": "openstack",
"vm_host": null,
"os_type": null,
"arch": null,
"ssh_pub_key": null,
"description": null
},
{
"is_vm": true,
"locked": false,
"locked_since": null,
"locked_by": null,
"up": true,
"mac_address": null,
"name": "the-re013",
"os_version": null,
"machine_type": "openstack",
"vm_host": null,
"os_type": null,
"arch": null,
"ssh_pub_key": null,
"description": null
},
{
"is_vm": true,
"locked": false,
"locked_since": null,
"locked_by": null,
"up": true,
"mac_address": null,
"name": "the-re014",
"os_version": null,
"machine_type": "openstack",
"vm_host": null,
"os_type": null,
"arch": null,
"ssh_pub_key": null,
"description": null
},
{
"is_vm": true,
"locked": false,
"locked_since": null,
"locked_by": null,
"up": true,
"mac_address": null,
"name": "the-re015",
"os_version": null,
"machine_type": "openstack",
"vm_host": null,
"os_type": null,
"arch": null,
"ssh_pub_key": null,
"description": null
},
{
"is_vm": true,
"locked": false,
"locked_since": null,
"locked_by": null,
"up": true,
"mac_address": null,
"name": "the-re016",
"os_version": null,
"machine_type": "openstack",
"vm_host": null,
"os_type": null,
"arch": null,
"ssh_pub_key": null,
"description": null
},
{
"is_vm": true,
"locked": false,
"locked_since": null,
"locked_by": null,
"up": true,
"mac_address": null,
"name": "the-re017",
"os_version": null,
"machine_type": "openstack",
"vm_host": null,
"os_type": null,
"arch": null,
"ssh_pub_key": null,
"description": null
},
{
"is_vm": true,
"locked": false,
"locked_since": null,
"locked_by": null,
"up": true,
"mac_address": null,
"name": "the-re018",
"os_version": null,
"machine_type": "openstack",
"vm_host": null,
"os_type": null,
"arch": null,
"ssh_pub_key": null,
"description": null
},
{
"is_vm": true,
"locked": false,
"locked_since": null,
"locked_by": null,
"up": true,
"mac_address": null,
"name": "the-re019",
"os_version": null,
"machine_type": "openstack",
"vm_host": null,
"os_type": null,
"arch": null,
"ssh_pub_key": null,
"description": null
}
]

2015-06-20 19:35:32,751.751 INFO:root:looking for the-re011
PASSED
teuthology/test/integration/openstack-integration.py::TestLock::test_lock_unlock 2015-06-20 19:35:33,340.340 DEBUG:teuthology.lock:locked the-re010 as ubuntu@teuthology
2015-06-20 19:35:33,360.360 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:35:33,360.360 DEBUG:teuthology.provision:OpenStack:destroy
2015-06-20 19:35:33,360.360 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:35:34,297.297 ERROR:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 error ERROR: openstack No server with a name or ID of 'the-re010' exists.

2015-06-20 19:35:34,300.300 DEBUG:teuthology.provision:OpenStack:create
2015-06-20 19:35:34,300.300 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack network show -f json teuthology-test
2015-06-20 19:35:35,725.725 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack network show -f json teuthology-test output [{"Field": "id", "Value": "582950be-f33c-4375-8f8e-14606143e6d7"}, {"Field": "name", "Value": "teuthology-test"}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "router_type", "Value": "Internal"}, {"Field": "shared", "Value": false}, {"Field": "state", "Value": "UP"}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "subnets", "Value": "5ecec13c-df5b-42f5-9f54-2bf1c2d95d9d"}]

2015-06-20 19:35:35,730.730 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack flavor list -f json
2015-06-20 19:35:36,862.862 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack flavor list -f json output [{"ID": "01912b08-dfe0-480e-9b38-5ba8c310e08f", "Name": "2cpu-3G", "RAM": 3192, "Disk": 10, "Ephemeral": 0, "VCPUs": 2, "Is Public": true}, {"ID": "1", "Name": "m1.tiny", "RAM": 512, "Disk": 1, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "2", "Name": "m1.small", "RAM": 1024, "Disk": 10, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "24f09411-ab77-468c-b42c-93d7168f87f6", "Name": "1cpu-256M", "RAM": 256, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "3", "Name": "m1.medium", "RAM": 3192, "Disk": 10, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "4", "Name": "m1.large", "RAM": 8192, "Disk": 80, "Ephemeral": 0, "VCPUs": 4, "Is Public": true}, {"ID": "4ed21e7a-52a6-4b0f-9754-74ae925109b6", "Name": "1cpu-512M", "RAM": 512, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "5", "Name": "m1.xlarge", "RAM": 16384, "Disk": 160, "Ephemeral": 0, "VCPUs": 8, "Is Public": true}, {"ID": "b1bbe2bd-c3bd-45a4-9a3e-704547ab0c69", "Name": "2cpu-4G", "RAM": 4096, "Disk": 0, "Ephemeral": 0, "VCPUs": 2, "Is Public": true}, {"ID": "c16e3f8b-c9ce-442b-8cfa-a23aeff6928c", "Name": "6cpu-8G", "RAM": 8192, "Disk": 0, "Ephemeral": 0, "VCPUs": 6, "Is Public": true}, {"ID": "c7798fdc-a3b0-4512-8c21-43227e987801", "Name": "1cpu-1G", "RAM": 1024, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "f52f848c-6efc-43e7-96d0-d3b04686881b", "Name": "1cpu-2G", "RAM": 2048, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "fe0a54e0-3552-479d-9374-1b131486a0de", "Name": "1cpu-4G", "RAM": 4096, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}]

2015-06-20 19:35:36,865.865 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack volume show -f json the-re010-0
2015-06-20 19:35:38,020.020 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack volume show -f json the-re010-0 output [{"Field": "attachments", "Value": []}, {"Field": "availability_zone", "Value": "ovh"}, {"Field": "bootable", "Value": "false"}, {"Field": "created_at", "Value": "2015-06-14T16:57:58.000000"}, {"Field": "display_description", "Value": null}, {"Field": "display_name", "Value": "the-re010-0"}, {"Field": "id", "Value": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}, {"Field": "properties", "Value": "readonly='False'"}, {"Field": "size", "Value": 1}, {"Field": "snapshot_id", "Value": null}, {"Field": "source_volid", "Value": null}, {"Field": "status", "Value": "available"}, {"Field": "type", "Value": "ovh"}]

2015-06-20 19:35:38,024.024 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server create --availability-zone ovh --block-device-mapping /dev/vdb=ab5b1622-2db5-4e95-80c4-9384f0e43bdd --image centos-7 --flavor m1.small --key-name teuthology --user-data /tmp/tmpgc1055 --nic net-id=582950be-f33c-4375-8f8e-14606143e6d7,v4-fixed-ip=10.50.50.10 --wait the-re010
2015-06-20 19:35:51,094.094 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server create --availability-zone ovh --block-device-mapping /dev/vdb=ab5b1622-2db5-4e95-80c4-9384f0e43bdd --image centos-7 --flavor m1.small --key-name teuthology --user-data /tmp/tmpgc1055 --nic net-id=582950be-f33c-4375-8f8e-14606143e6d7,v4-fixed-ip=10.50.50.10 --wait the-re010 output
+--------------------------------------+----------------------------------------------------------+
| Field | Value |
+--------------------------------------+----------------------------------------------------------+
| OS-DCF:diskConfig | MANUAL |
| OS-EXT-AZ:availability_zone | ovh |
| OS-EXT-STS:power_state | 1 |
| OS-EXT-STS:task_state | None |
| OS-EXT-STS:vm_state | active |
| OS-SRV-USG:launched_at | 2015-06-20T19:35:46.000000 |
| OS-SRV-USG:terminated_at | None |
| accessIPv4 | |
| accessIPv6 | |
| addresses | teuthology-test=10.50.50.10 |
| adminPass | mEbPyU97Cysf |
| config_drive | |
| created | 2015-06-20T19:35:40Z |
| flavor | m1.small (2) |
| hostId | 6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162 |
| id | 623e7471-e59f-43d7-a85a-20704b557666 |
| image | centos-7 (20ef94c3-0567-498f-836c-613c7a9c6629) |
| key_name | teuthology |
| name | the-re010 |
| os-extended-volumes:volumes_attached | [{u'id': u'ab5b1622-2db5-4e95-80c4-9384f0e43bdd'}] |
| progress | 0 |
| project_id | a5fa44393fbf4a1fa006d83b996595ef |
| properties | |
| security_groups | [{u'name': u'default'}] |
| status | ACTIVE |
| updated | 2015-06-20T19:35:46Z |
| user_id | 0df7d9fa2d694b59821acd1d6c0e2291 |
+--------------------------------------+----------------------------------------------------------+

2015-06-20 19:36:52,219.219 DEBUG:teuthology.provision:cloud_init_wait
2015-06-20 19:36:52,763.763 DEBUG:teuthology.provision:cloud_init_wait grep 'The system is finally up' /var/log/cloud-init.log
2015-06-20 19:36:53,210.210 DEBUG:teuthology.provision:cloud_init_wait stdout grep 'The system is finally up' /var/log/cloud-init.log Jun 20 19:36:49 localhost cloud-init: The system is finally up, after 60.11 seconds

2015-06-20 19:36:53,216.216 DEBUG:teuthology.provision:cloud_init_wait stderr grep 'The system is finally up' /var/log/cloud-init.log
2015-06-20 19:36:53,252.252 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:36:53,252.252 DEBUG:teuthology.provision:OpenStack:destroy
2015-06-20 19:36:53,252.252 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:36:54,943.943 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 output [{"Field": "OS-DCF:diskConfig", "Value": "MANUAL"}, {"Field": "OS-EXT-AZ:availability_zone", "Value": "ovh"}, {"Field": "OS-EXT-STS:power_state", "Value": 1}, {"Field": "OS-EXT-STS:task_state", "Value": null}, {"Field": "OS-EXT-STS:vm_state", "Value": "active"}, {"Field": "OS-SRV-USG:launched_at", "Value": "2015-06-20T19:35:46.000000"}, {"Field": "OS-SRV-USG:terminated_at", "Value": null}, {"Field": "accessIPv4", "Value": ""}, {"Field": "accessIPv6", "Value": ""}, {"Field": "addresses", "Value": "teuthology-test=10.50.50.10"}, {"Field": "config_drive", "Value": ""}, {"Field": "created", "Value": "2015-06-20T19:35:40Z"}, {"Field": "flavor", "Value": "m1.small (2)"}, {"Field": "hostId", "Value": "6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162"}, {"Field": "id", "Value": "623e7471-e59f-43d7-a85a-20704b557666"}, {"Field": "image", "Value": "centos-7 (20ef94c3-0567-498f-836c-613c7a9c6629)"}, {"Field": "key_name", "Value": "teuthology"}, {"Field": "name", "Value": "the-re010"}, {"Field": "os-extended-volumes:volumes_attached", "Value": [{"id": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}]}, {"Field": "progress", "Value": 0}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "properties", "Value": ""}, {"Field": "security_groups", "Value": [{"name": "default"}]}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "updated", "Value": "2015-06-20T19:35:46Z"}, {"Field": "user_id", "Value": "0df7d9fa2d694b59821acd1d6c0e2291"}]

2015-06-20 19:36:54,948.948 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server delete the-re010
2015-06-20 19:36:56,438.438 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server delete the-re010 output
2015-06-20 19:36:56,440.440 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:36:58,064.064 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 output [{"Field": "OS-DCF:diskConfig", "Value": "MANUAL"}, {"Field": "OS-EXT-AZ:availability_zone", "Value": "ovh"}, {"Field": "OS-EXT-STS:power_state", "Value": 1}, {"Field": "OS-EXT-STS:task_state", "Value": "deleting"}, {"Field": "OS-EXT-STS:vm_state", "Value": "active"}, {"Field": "OS-SRV-USG:launched_at", "Value": "2015-06-20T19:35:46.000000"}, {"Field": "OS-SRV-USG:terminated_at", "Value": null}, {"Field": "accessIPv4", "Value": ""}, {"Field": "accessIPv6", "Value": ""}, {"Field": "addresses", "Value": "teuthology-test=10.50.50.10"}, {"Field": "config_drive", "Value": ""}, {"Field": "created", "Value": "2015-06-20T19:35:40Z"}, {"Field": "flavor", "Value": "m1.small (2)"}, {"Field": "hostId", "Value": "6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162"}, {"Field": "id", "Value": "623e7471-e59f-43d7-a85a-20704b557666"}, {"Field": "image", "Value": "centos-7 (20ef94c3-0567-498f-836c-613c7a9c6629)"}, {"Field": "key_name", "Value": "teuthology"}, {"Field": "name", "Value": "the-re010"}, {"Field": "os-extended-volumes:volumes_attached", "Value": [{"id": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}]}, {"Field": "progress", "Value": 0}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "properties", "Value": ""}, {"Field": "security_groups", "Value": [{"name": "default"}]}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "updated", "Value": "2015-06-20T19:36:56Z"}, {"Field": "user_id", "Value": "0df7d9fa2d694b59821acd1d6c0e2291"}]

2015-06-20 19:37:58,129.129 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:37:59,082.082 ERROR:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 error ERROR: openstack No server with a name or ID of 'the-re010' exists.

2015-06-20 19:37:59,506.506 INFO:teuthology.lock:unlocked the-re010
2015-06-20 19:38:00,046.046 DEBUG:teuthology.lock:locked the-re010 as ubuntu@teuthology
2015-06-20 19:38:00,065.065 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:38:00,065.065 DEBUG:teuthology.provision:OpenStack:destroy
2015-06-20 19:38:00,065.065 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:38:01,166.166 ERROR:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 error ERROR: openstack No server with a name or ID of 'the-re010' exists.

2015-06-20 19:38:01,168.168 DEBUG:teuthology.provision:OpenStack:create
2015-06-20 19:38:01,168.168 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack network show -f json teuthology-test
2015-06-20 19:38:02,040.040 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack network show -f json teuthology-test output [{"Field": "id", "Value": "582950be-f33c-4375-8f8e-14606143e6d7"}, {"Field": "name", "Value": "teuthology-test"}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "router_type", "Value": "Internal"}, {"Field": "shared", "Value": false}, {"Field": "state", "Value": "UP"}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "subnets", "Value": "5ecec13c-df5b-42f5-9f54-2bf1c2d95d9d"}]

2015-06-20 19:38:02,044.044 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack flavor list -f json
2015-06-20 19:38:02,974.974 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack flavor list -f json output [{"ID": "01912b08-dfe0-480e-9b38-5ba8c310e08f", "Name": "2cpu-3G", "RAM": 3192, "Disk": 10, "Ephemeral": 0, "VCPUs": 2, "Is Public": true}, {"ID": "1", "Name": "m1.tiny", "RAM": 512, "Disk": 1, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "2", "Name": "m1.small", "RAM": 1024, "Disk": 10, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "24f09411-ab77-468c-b42c-93d7168f87f6", "Name": "1cpu-256M", "RAM": 256, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "3", "Name": "m1.medium", "RAM": 3192, "Disk": 10, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "4", "Name": "m1.large", "RAM": 8192, "Disk": 80, "Ephemeral": 0, "VCPUs": 4, "Is Public": true}, {"ID": "4ed21e7a-52a6-4b0f-9754-74ae925109b6", "Name": "1cpu-512M", "RAM": 512, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "5", "Name": "m1.xlarge", "RAM": 16384, "Disk": 160, "Ephemeral": 0, "VCPUs": 8, "Is Public": true}, {"ID": "b1bbe2bd-c3bd-45a4-9a3e-704547ab0c69", "Name": "2cpu-4G", "RAM": 4096, "Disk": 0, "Ephemeral": 0, "VCPUs": 2, "Is Public": true}, {"ID": "c16e3f8b-c9ce-442b-8cfa-a23aeff6928c", "Name": "6cpu-8G", "RAM": 8192, "Disk": 0, "Ephemeral": 0, "VCPUs": 6, "Is Public": true}, {"ID": "c7798fdc-a3b0-4512-8c21-43227e987801", "Name": "1cpu-1G", "RAM": 1024, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "f52f848c-6efc-43e7-96d0-d3b04686881b", "Name": "1cpu-2G", "RAM": 2048, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}, {"ID": "fe0a54e0-3552-479d-9374-1b131486a0de", "Name": "1cpu-4G", "RAM": 4096, "Disk": 0, "Ephemeral": 0, "VCPUs": 1, "Is Public": true}]

2015-06-20 19:38:02,977.977 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack volume show -f json the-re010-0
2015-06-20 19:38:03,943.943 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack volume show -f json the-re010-0 output [{"Field": "attachments", "Value": []}, {"Field": "availability_zone", "Value": "ovh"}, {"Field": "bootable", "Value": "false"}, {"Field": "created_at", "Value": "2015-06-14T16:57:58.000000"}, {"Field": "display_description", "Value": null}, {"Field": "display_name", "Value": "the-re010-0"}, {"Field": "id", "Value": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}, {"Field": "properties", "Value": "readonly='False'"}, {"Field": "size", "Value": 1}, {"Field": "snapshot_id", "Value": null}, {"Field": "source_volid", "Value": null}, {"Field": "status", "Value": "available"}, {"Field": "type", "Value": "ovh"}]

2015-06-20 19:38:03,944.944 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server create --availability-zone ovh --block-device-mapping /dev/vdb=ab5b1622-2db5-4e95-80c4-9384f0e43bdd --image ubuntu-trusty-14.04 --flavor m1.small --key-name teuthology --user-data /tmp/tmpulj2fY --nic net-id=582950be-f33c-4375-8f8e-14606143e6d7,v4-fixed-ip=10.50.50.10 --wait the-re010
2015-06-20 19:38:17,320.320 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server create --availability-zone ovh --block-device-mapping /dev/vdb=ab5b1622-2db5-4e95-80c4-9384f0e43bdd --image ubuntu-trusty-14.04 --flavor m1.small --key-name teuthology --user-data /tmp/tmpulj2fY --nic net-id=582950be-f33c-4375-8f8e-14606143e6d7,v4-fixed-ip=10.50.50.10 --wait the-re010 output
+--------------------------------------+------------------------------------------------------------+
| Field | Value |
+--------------------------------------+------------------------------------------------------------+
| OS-DCF:diskConfig | MANUAL |
| OS-EXT-AZ:availability_zone | ovh |
| OS-EXT-STS:power_state | 1 |
| OS-EXT-STS:task_state | None |
| OS-EXT-STS:vm_state | active |
| OS-SRV-USG:launched_at | 2015-06-20T19:38:11.000000 |
| OS-SRV-USG:terminated_at | None |
| accessIPv4 | |
| accessIPv6 | |
| addresses | teuthology-test=10.50.50.10 |
| adminPass | D7P9XTM6bwdP |
| config_drive | |
| created | 2015-06-20T19:38:06Z |
| flavor | m1.small (2) |
| hostId | 6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162 |
| id | 7d36dbac-4591-4dc0-bcbc-027e881b2405 |
| image | ubuntu-trusty-14.04 (62d1c667-f5bb-4754-8606-3479569fd5fe) |
| key_name | teuthology |
| name | the-re010 |
| os-extended-volumes:volumes_attached | [{u'id': u'ab5b1622-2db5-4e95-80c4-9384f0e43bdd'}] |
| progress | 0 |
| project_id | a5fa44393fbf4a1fa006d83b996595ef |
| properties | |
| security_groups | [{u'name': u'default'}] |
| status | ACTIVE |
| updated | 2015-06-20T19:38:11Z |
| user_id | 0df7d9fa2d694b59821acd1d6c0e2291 |
+--------------------------------------+------------------------------------------------------------+

2015-06-20 19:39:18,449.449 DEBUG:teuthology.provision:cloud_init_wait
2015-06-20 19:39:18,972.972 DEBUG:teuthology.provision:cloud_init_wait grep 'The system is finally up' /var/log/cloud-init.log
2015-06-20 19:39:20,185.185 DEBUG:teuthology.provision:cloud_init_wait stdout grep 'The system is finally up' /var/log/cloud-init.log Jun 20 19:38:41 the-re010 [CLOUDINIT] util.py[DEBUG]: The system is finally up, after 28.98 seconds

2015-06-20 19:39:20,192.192 DEBUG:teuthology.provision:cloud_init_wait stderr grep 'The system is finally up' /var/log/cloud-init.log
2015-06-20 19:39:20,252.252 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:39:20,252.252 DEBUG:teuthology.provision:OpenStack:destroy
2015-06-20 19:39:20,252.252 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:39:21,775.775 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 output [{"Field": "OS-DCF:diskConfig", "Value": "MANUAL"}, {"Field": "OS-EXT-AZ:availability_zone", "Value": "ovh"}, {"Field": "OS-EXT-STS:power_state", "Value": 1}, {"Field": "OS-EXT-STS:task_state", "Value": null}, {"Field": "OS-EXT-STS:vm_state", "Value": "active"}, {"Field": "OS-SRV-USG:launched_at", "Value": "2015-06-20T19:38:11.000000"}, {"Field": "OS-SRV-USG:terminated_at", "Value": null}, {"Field": "accessIPv4", "Value": ""}, {"Field": "accessIPv6", "Value": ""}, {"Field": "addresses", "Value": "teuthology-test=10.50.50.10"}, {"Field": "config_drive", "Value": ""}, {"Field": "created", "Value": "2015-06-20T19:38:06Z"}, {"Field": "flavor", "Value": "m1.small (2)"}, {"Field": "hostId", "Value": "6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162"}, {"Field": "id", "Value": "7d36dbac-4591-4dc0-bcbc-027e881b2405"}, {"Field": "image", "Value": "ubuntu-trusty-14.04 (62d1c667-f5bb-4754-8606-3479569fd5fe)"}, {"Field": "key_name", "Value": "teuthology"}, {"Field": "name", "Value": "the-re010"}, {"Field": "os-extended-volumes:volumes_attached", "Value": [{"id": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}]}, {"Field": "progress", "Value": 0}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "properties", "Value": ""}, {"Field": "security_groups", "Value": [{"name": "default"}]}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "updated", "Value": "2015-06-20T19:38:11Z"}, {"Field": "user_id", "Value": "0df7d9fa2d694b59821acd1d6c0e2291"}]

2015-06-20 19:39:21,776.776 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server delete the-re010
2015-06-20 19:39:23,101.101 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server delete the-re010 output
2015-06-20 19:39:23,104.104 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:39:24,697.697 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 output [{"Field": "OS-DCF:diskConfig", "Value": "MANUAL"}, {"Field": "OS-EXT-AZ:availability_zone", "Value": "ovh"}, {"Field": "OS-EXT-STS:power_state", "Value": 1}, {"Field": "OS-EXT-STS:task_state", "Value": "deleting"}, {"Field": "OS-EXT-STS:vm_state", "Value": "active"}, {"Field": "OS-SRV-USG:launched_at", "Value": "2015-06-20T19:38:11.000000"}, {"Field": "OS-SRV-USG:terminated_at", "Value": null}, {"Field": "accessIPv4", "Value": ""}, {"Field": "accessIPv6", "Value": ""}, {"Field": "addresses", "Value": "teuthology-test=10.50.50.10"}, {"Field": "config_drive", "Value": ""}, {"Field": "created", "Value": "2015-06-20T19:38:06Z"}, {"Field": "flavor", "Value": "m1.small (2)"}, {"Field": "hostId", "Value": "6bd270f26cfd12a16ec052558a512048297784e9bf2dfe76235b4162"}, {"Field": "id", "Value": "7d36dbac-4591-4dc0-bcbc-027e881b2405"}, {"Field": "image", "Value": "ubuntu-trusty-14.04 (62d1c667-f5bb-4754-8606-3479569fd5fe)"}, {"Field": "key_name", "Value": "teuthology"}, {"Field": "name", "Value": "the-re010"}, {"Field": "os-extended-volumes:volumes_attached", "Value": [{"id": "ab5b1622-2db5-4e95-80c4-9384f0e43bdd"}]}, {"Field": "progress", "Value": 0}, {"Field": "project_id", "Value": "a5fa44393fbf4a1fa006d83b996595ef"}, {"Field": "properties", "Value": ""}, {"Field": "security_groups", "Value": [{"name": "default"}]}, {"Field": "status", "Value": "ACTIVE"}, {"Field": "updated", "Value": "2015-06-20T19:39:22Z"}, {"Field": "user_id", "Value": "0df7d9fa2d694b59821acd1d6c0e2291"}]

2015-06-20 19:40:24,761.761 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010
2015-06-20 19:40:25,602.602 ERROR:teuthology.misc:. teuthology/test/integration/openrc.sh && openstack server show -f json the-re010 error ERROR: openstack No server with a name or ID of 'the-re010' exists.

2015-06-20 19:40:25,866.866 INFO:teuthology.lock:unlocked the-re010
PASSED
teuthology/test/integration/openstack-integration.py::TestLock::test_main 2015-06-20 19:40:25,879.879 ERROR:teuthology.lock:--lock requires specific machines passed as arguments
PASSEDsudo: unable to resolve host teuthology
* Restarting in-memory queueing server beanstalkd
...done.
2015-06-20 19:40:26,901.901 INFO:root:trying OpenStack cluster the-re
2015-06-20 19:40:26,901.901 DEBUG:teuthology.provision:OpenStack: {'clusters': {'the-re': {'subnet': '10.50.50.0/24', 'network': 'teuthology-test', 'images': {'centos-7.0': 'centos-7', 'ubuntu-14.04': 'ubuntu-trusty-14.04'}, 'openrc.sh': 'teuthology/test/integration/openrc.sh', 'volume-create': '--availability-zone ovh --type ovh', 'server-create': '--availability-zone ovh'}}, 'user-data': {'default': 'teuthology/openstack-default-user-data.txt', 'ubuntu-14.04': 'teuthology/openstack-ubuntu-user-data.txt'}, 'ssh-key': 'teuthology/test/integration/teuthology.pem', 'default-volumes': {'count': 1, 'size': 1}, 'default-size': {'disk-size': 10, 'ram': 1024, 'cpus': 1}}
2015-06-20 19:40:26,902.902 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list
2015-06-20 19:40:27,889.889 DEBUG:teuthology.misc:. teuthology/test/integration/openrc.sh && timeout 5 openstack server list output +--------------------------------------+------------+--------+--------------------------------------------------------------+
| ID | Name | Status | Networks |
+--------------------------------------+------------+--------+--------------------------------------------------------------+
| ecd351e4-3301-42c5-8126-f25be68155e9 | teuthology | ACTIVE | fsf-lan=10.0.3.31, 93.20.168.190; teuthology-test=10.50.50.2 |
+--------------------------------------+------------+--------+--------------------------------------------------------------+

2015-06-20 19:40:27,892.892 INFO:root:using OpenStack cluster the-re
2015-06-20 19:40:27,892.892 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
2015-06-20 19:40:31,829.829 DEBUG:teuthology.misc:
set -ex
cd ../paddles
(
echo "delete from nodes;"
for id in $(seq 10 19) ; do
echo "insert into nodes (id,name,machine_type,is_vm,locked,up) values ($id, 'the-re0$id', 'openstack', 1, 0, 1);" # noqa
done
) | sqlite3 dev.db
output + cd ../paddles
+ sqlite3 dev.db
+ echo delete from nodes;
+ seq 10 19
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (10, 'the-re010', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (11, 'the-re011', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (12, 'the-re012', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (13, 'the-re013', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (14, 'the-re014', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (15, 'the-re015', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (16, 'the-re016', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (17, 'the-re017', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (18, 'the-re018', 'openstack', 1, 0, 1);
+ echo insert into nodes (id,name,machine_type,is_vm,locked,up) values (19, 'the-re019', 'openstack', 1, 0, 1);



============================================================================================ 7 passed in 655.14 seconds ============================================================================================
(1-1/3)