1 2017-06-22 13:40:02.921 20865 INFO keystone.token.persistence.backends.sql [-] Total expired tokens removed: 0 2 2017-06-22 13:40:15.314 4096 INFO nova.osapi_compute.wsgi.server [req-775c5e37-3d12-404f-a9e6-56deb166ad04 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/flavors/detail HTTP/1.1" status: 200 len: 2403 time: 0.1748371 3 2017-06-22 13:40:15.827 8860 INFO keystone.common.wsgi [req-28dc51e5-94ea-499e-8375-25adc09567b8 9760566253204a7d8781c22be9ca81d6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 4 2017-06-22 13:40:17.612 4096 INFO nova.osapi_compute.wsgi.server [req-d79d98f3-afa9-4921-85f5-bd28feb2b09f 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/servers/detail?limit=21&project_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" status: 200 len: 347 time: 0.9729328 5 2017-06-22 13:40:17.812 8861 INFO keystone.common.wsgi [req-4f3653d9-8e25-43b6-ab26-59d0f6fd95ba 1f8b1698b91c42169437f856426fc0b1 - - default -] GET http://10.0.2.15:5000/v3/users/1f8b1698b91c42169437f856426fc0b1/projects 6 2017-06-22 13:40:18.798 4096 INFO nova.osapi_compute.wsgi.server [req-aebb5b36-c672-4bda-8708-b7334a829c41 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/limits?reserved=1 HTTP/1.1" status: 200 len: 844 time: 0.1747451 7 2017-06-22 13:40:19.027 4096 INFO nova.osapi_compute.wsgi.server [req-771a10e9-b8ff-436c-a9ac-828c2cede6d2 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/limits?reserved=1 HTTP/1.1" status: 200 len: 844 time: 0.1913240 8 2017-06-22 13:40:24.122 8860 INFO keystone.common.wsgi [req-9ff8eaf1-28f2-4bca-b1f9-b95bf0cf6f2f 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 9 2017-06-22 13:40:24.141 8860 INFO keystone.common.wsgi [req-5a2ae323-a697-44c1-884b-5fc393b08e66 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 10 2017-06-22 13:40:24.757 8861 INFO keystone.common.wsgi [req-b12e8b1e-70c8-43d5-8f07-ebbac192376d - - - - -] GET http://10.0.2.15:5000/v3/ 11 2017-06-22 13:40:25.058 4096 INFO nova.osapi_compute.wsgi.server [req-cbb97468-40a6-49dc-9868-50f3fa9ea9db 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/flavors/detail?is_public=None HTTP/1.1" status: 200 len: 2403 time: 1.3639779 12 2017-06-22 13:40:25.406 4096 INFO nova.osapi_compute.wsgi.server [req-af40beed-d079-4949-8d2d-f5b7fc337d4f 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/os-availability-zone HTTP/1.1" status: 200 len: 429 time: 1.6921120 13 2017-06-22 13:40:25.539 8860 INFO keystone.common.wsgi [req-c3db957d-bcc7-4960-a673-9130163d3985 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 14 2017-06-22 13:40:25.574 8860 INFO keystone.common.wsgi [req-33a016f2-7b0e-4021-ab3e-bff2887d7297 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 15 2017-06-22 13:40:25.619 8861 INFO keystone.common.wsgi [req-02640585-db28-47d0-a4e0-34e1994cc842 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] POST http://10.0.2.15:5000/v3/auth/tokens 16 2017-06-22 13:40:26.550 3967 INFO neutron.wsgi [req-81a8059b-fce7-45ee-9624-3ea1622b86fc 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:40:26] "GET /v2.0/extensions.json HTTP/1.1" 200 7506 2.786646 17 2017-06-22 13:40:26.643 4096 WARNING oslo_db.sqlalchemy.utils [req-4fb7caa4-5d02-4ff5-a23b-c7231d851be9 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Unique keys not in sort_keys. The sorting order may be unstable. 18 2017-06-22 13:40:26.745 4096 WARNING oslo_db.sqlalchemy.utils [req-4fb7caa4-5d02-4ff5-a23b-c7231d851be9 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Unique keys not in sort_keys. The sorting order may be unstable. 19 2017-06-22 13:40:26.787 4096 INFO nova.osapi_compute.wsgi.server [req-4fb7caa4-5d02-4ff5-a23b-c7231d851be9 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/os-keypairs HTTP/1.1" status: 200 len: 348 time: 3.0098670 20 2017-06-22 13:40:27.182 3967 INFO neutron.wsgi [req-787f6f7c-5734-4507-bcfd-92c4698de9e6 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:40:27] "GET /v2.0/security-groups.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 2574 0.531867 21 2017-06-22 13:40:27.264 8860 INFO keystone.common.wsgi [req-63a578b6-1968-4498-a169-a906ad183d9e 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 22 2017-06-22 13:40:27.697 4096 INFO nova.osapi_compute.wsgi.server [req-8b15e2ab-795d-4a35-ba7a-376fd3e6fd0e 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/limits?reserved=1 HTTP/1.1" status: 200 len: 844 time: 1.1889310 23 2017-06-22 13:40:28.898 3967 INFO neutron.wsgi [req-218281d3-1cda-4208-92a6-b4f9104166cd 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:40:28] "GET /v2.0/networks.json?shared=False&tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 905 0.511961 24 2017-06-22 13:40:29.198 3967 INFO neutron.wsgi [req-3d1832cb-98c4-4a57-a41b-80a10436c920 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:40:29] "GET /v2.0/subnets.json HTTP/1.1" 200 1509 0.294601 25 2017-06-22 13:40:29.293 3967 INFO neutron.wsgi [req-7c54c18f-97e6-4d9c-995f-1e3318f5c8aa 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:40:29] "GET /v2.0/networks.json?shared=True HTTP/1.1" 200 214 0.090343 26 2017-06-22 13:40:29.653 3967 INFO neutron.wsgi [req-3403ec33-3bc6-4655-a6ee-6eadc1a232e1 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:40:29] "GET /v2.0/subnets.json HTTP/1.1" 200 1509 0.347533 27 2017-06-22 13:40:30.603 4096 INFO nova.osapi_compute.wsgi.server [req-f1555890-bf3a-4b13-8813-732734bd02f2 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/os-server-groups HTTP/1.1" status: 200 len: 353 time: 0.1572490 28 2017-06-22 13:40:31.564 3967 INFO neutron.wsgi [req-4ce1503f-39f5-4898-a5eb-d04fbd6b7614 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:40:31] "GET /v2.0/ports.json?network_id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 1033 1.097335 29 2017-06-22 13:40:33.794 8860 INFO keystone.common.wsgi [req-afb7a1c7-31a9-4bf6-aaa5-03f470db2106 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 30 2017-06-22 13:40:34.419 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=512MB phys_disk=49GB used_disk=0GB total_vcpus=1 used_vcpus=0 pci_stats=[] 31 2017-06-22 13:40:50.961 1531 INFO nova.scheduler.host_manager [req-81076c78-af1f-4e45-8e4a-935411722495 - - - - -] Successfully synced instances from host 'localhost.localdomain'. 32 2017-06-22 13:41:02.815 20924 INFO keystone.token.persistence.backends.sql [-] Total expired tokens removed: 0 33 2017-06-22 13:41:07.643 8860 INFO keystone.common.wsgi [req-908cfe6d-6270-412f-9f4a-ad622fe21fab 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 34 2017-06-22 13:41:08.612 4096 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 35 2017-06-22 13:41:09.149 8860 INFO keystone.common.wsgi [req-7ed1f14a-2382-4f11-a04a-cf6648876483 9760566253204a7d8781c22be9ca81d6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 36 2017-06-22 13:41:10.494 8860 INFO keystone.common.wsgi [req-e8251e3f-995b-4621-9e08-d58c43129a4b 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 37 2017-06-22 13:41:11.828 8860 INFO keystone.common.wsgi [req-dd150b28-1368-4793-b0af-72f3f205b204 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 38 2017-06-22 13:41:13.015 3967 INFO neutron.wsgi [req-afc97a39-70f7-43ac-8a7c-ef27360926de 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:13] "GET /v2.0/security-groups.json?fields=id&id=9a1c031e-50c4-4e6e-98bf-52f8cd94f17a HTTP/1.1" 200 267 3.046564 39 2017-06-22 13:41:13.317 3967 INFO neutron.wsgi [req-3eda91d2-0313-4a01-a96e-7f13bed6b57c 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:13] "GET /v2.0/security-groups/9a1c031e-50c4-4e6e-98bf-52f8cd94f17a.json HTTP/1.1" 200 2571 0.289147 40 2017-06-22 13:41:13.916 3967 INFO neutron.wsgi [req-a9a28f1c-a771-40dc-af84-1595fe421d18 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:13] "GET /v2.0/networks.json?id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 905 0.588740 41 2017-06-22 13:41:13.981 3967 INFO neutron.wsgi [req-09d72e22-71d2-4146-95f3-be523ab9a4df 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:13] "GET /v2.0/quotas/355c595975894e7d8caa9c3af1ad3cb7.json HTTP/1.1" 200 370 0.056713 42 2017-06-22 13:41:14.188 3967 INFO neutron.wsgi [req-27448306-cb1e-48b1-b12f-e2ee347cff92 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:14] "GET /v2.0/ports.json?fields=id&tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 211 0.196874 43 2017-06-22 13:41:14.754 4096 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 44 2017-06-22 13:41:15.124 4096 INFO nova.osapi_compute.wsgi.server [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "POST /v2.1/355c595975894e7d8caa9c3af1ad3cb7/os-volumes_boot HTTP/1.1" status: 202 len: 918 time: 7.8752060 45 2017-06-22 13:41:15.165 8861 INFO keystone.common.wsgi [req-f21a8942-22cb-4fc0-afd4-76ba79c02a0f - - - - -] POST http://10.0.2.15:5000/v3/auth/tokens 46 2017-06-22 13:41:15.704 3967 INFO neutron.wsgi [req-561bfcea-63b9-4b17-bcd8-99bf94bc2cb8 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:15] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 211 0.283738 47 2017-06-22 13:41:15.793 4096 INFO nova.osapi_compute.wsgi.server [req-129269da-c369-4f4b-8dd3-cff6a0cb942d 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/servers/f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" status: 200 len: 1542 time: 0.6238599 48 2017-06-22 13:41:16.096 4096 INFO nova.osapi_compute.wsgi.server [req-20292c0a-b725-4c13-b720-7a1da024f5d5 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/flavors/detail HTTP/1.1" status: 200 len: 2403 time: 0.1918740 49 2017-06-22 13:41:16.426 8860 INFO keystone.common.wsgi [req-1f2493aa-9e1a-4eaf-ab7c-64fabc3bfa60 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 50 2017-06-22 13:41:17.667 1578 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 51 2017-06-22 13:41:17.745 8860 INFO keystone.common.wsgi [req-d8e418c0-e4b9-45b3-b4d9-edae5ab15777 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 52 2017-06-22 13:41:18.707 1578 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 53 2017-06-22 13:41:18.784 3610 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 54 2017-06-22 13:41:18.844 3967 INFO neutron.wsgi [req-e396f909-f6d5-484f-9caa-6105f58bd3e9 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:18] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 211 1.798780 55 2017-06-22 13:41:18.913 3610 INFO nova.compute.claims [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Attempting claim: memory 512 MB, disk 1 GB, vcpus 1 CPU 56 2017-06-22 13:41:18.914 3610 INFO nova.compute.claims [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Total memory: 7823 MB, used: 512.00 MB 57 2017-06-22 13:41:18.915 3610 INFO nova.compute.claims [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] memory limit: 11734.50 MB, free: 11222.50 MB 58 2017-06-22 13:41:18.916 3610 INFO nova.compute.claims [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Total disk: 49 GB, used: 0.00 GB 59 2017-06-22 13:41:18.916 3610 INFO nova.compute.claims [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Total vcpu: 1 VCPU, used: 0.00 VCPU 60 2017-06-22 13:41:18.916 3610 INFO nova.compute.claims [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] disk limit: 49.00 GB, free: 49.00 GB 61 2017-06-22 13:41:18.917 3610 INFO nova.compute.claims [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Claim successful 62 2017-06-22 13:41:18.917 3610 INFO nova.compute.claims [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] vcpu limit: 16.00 VCPU, free: 16.00 VCPU 63 2017-06-22 13:41:19.012 4096 INFO nova.osapi_compute.wsgi.server [req-d3e88f5e-11c6-43cb-bc42-c353ec56e06b 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/servers/detail?limit=21&project_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" status: 200 len: 1545 time: 2.7370160 64 2017-06-22 13:41:19.273 3967 INFO neutron.wsgi [req-153f08f8-929d-4cd8-96f1-f75d67deb2ae 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:19] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 211 0.251021 65 2017-06-22 13:41:19.418 3967 INFO neutron.wsgi [req-89e50e0e-732d-4bd1-8a39-c64b2d98df52 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:19] "GET /v2.0/floatingips.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 217 0.121458 66 2017-06-22 13:41:19.429 1578 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 67 2017-06-22 13:41:19.742 3967 INFO neutron.wsgi [req-8d0727b0-966f-46e8-8ab2-09bd7e799dd0 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:19] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 211 0.304818 68 2017-06-22 13:41:19.753 3610 INFO nova.scheduler.client.report [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Submitted allocation for instance 69 2017-06-22 13:41:20.313 1578 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 70 2017-06-22 13:41:20.587 3967 INFO neutron.wsgi [req-3b68fbbc-151e-4cf3-88a7-c1f3125e7c48 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:20] "GET /v2.0/networks.json HTTP/1.1" 200 1574 0.804365 71 2017-06-22 13:41:20.626 3610 WARNING nova.virt.libvirt.driver [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Ignoring supplied device name: /dev/vda. Libvirt can't honour user-supplied dev names 72 2017-06-22 13:41:20.627 3610 WARNING nova.virt.osinfo [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] Cannot find OS information - Reason: (No configuration information found for operating system Empty) 73 2017-06-22 13:41:21.092 1578 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 74 2017-06-22 13:41:21.184 3610 INFO nova.virt.block_device [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Booting with blank volume at /dev/vda 75 2017-06-22 13:41:21.774 8860 INFO keystone.common.wsgi [req-52370ce0-985d-4b84-b361-d4265e2bf71d ebd7bc00e2824e2d8b2f45c4d9b737d8 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 76 2017-06-22 13:41:21.927 3967 INFO neutron.wsgi [req-139df387-930f-48db-804f-bb23174259f6 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:21] "GET /v2.0/networks.json?id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 905 1.165132 77 2017-06-22 13:41:22.393 3967 INFO neutron.wsgi [req-3ed40e17-384a-4b30-8a28-d87fa7f8abc6 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:22] "GET /v2.0/subnets.json HTTP/1.1" 200 1509 1.783871 78 2017-06-22 13:41:22.456 8861 INFO keystone.common.wsgi [req-9fa5ed93-18ee-4200-83d8-12a95b55b233 1f8b1698b91c42169437f856426fc0b1 - - default -] GET http://10.0.2.15:5000/v3/users/1f8b1698b91c42169437f856426fc0b1/projects 79 2017-06-22 13:41:22.556 8860 INFO keystone.common.wsgi [req-aab3d2f1-d6d2-4f42-9bc9-8c227bcf81e8 - - - - -] POST http://10.0.2.15:35357/v2.0/tokens 80 2017-06-22 13:41:22.574 3967 INFO neutron.wsgi [req-0d6109a1-3ebb-4432-892f-c8504e8b7653 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:22] "GET /v2.0/security-groups.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 2574 0.635995 81 2017-06-22 13:41:23.892 4096 INFO nova.osapi_compute.wsgi.server [req-2a55ccc4-d397-4e93-84ba-0ad6c3e1c9c8 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/limits?reserved=1 HTTP/1.1" status: 200 len: 846 time: 0.2887950 82 2017-06-22 13:41:24.729 8860 INFO keystone.common.wsgi [req-9f7dacf0-e55a-44ac-acbc-a234c198d739 9760566253204a7d8781c22be9ca81d6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 83 2017-06-22 13:41:25.108 3967 INFO neutron.wsgi [req-80c98043-2692-4bc0-8795-d3e0ab7141de 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:25] "GET /v2.0/extensions.json HTTP/1.1" 200 7506 0.050126 84 2017-06-22 13:41:26.023 4096 INFO nova.osapi_compute.wsgi.server [req-adfe9a64-c838-4a23-9ea6-c0d72593715e 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/limits?reserved=1 HTTP/1.1" status: 200 len: 846 time: 0.1790731 85 2017-06-22 13:41:28.418 3640 INFO neutron.agent.securitygroups_rpc [req-d69c80ee-9df6-4c3c-b52e-432f5de91494 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] Security group member updated [u'9a1c031e-50c4-4e6e-98bf-52f8cd94f17a'] 86 2017-06-22 13:41:28.866 3967 INFO neutron.wsgi [req-d69c80ee-9df6-4c3c-b52e-432f5de91494 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:28] "POST /v2.0/ports.json HTTP/1.1" 201 1016 6.269821 87 2017-06-22 13:41:29.517 8860 INFO keystone.common.wsgi [req-eb0d9ee6-8347-460c-89d0-5689503a6cf0 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 88 2017-06-22 13:41:29.658 3967 INFO neutron.wsgi [req-5cf4f5eb-737a-46b1-9191-7cc252ed61ba 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:29] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 211 0.320068 89 2017-06-22 13:41:29.724 4096 INFO nova.osapi_compute.wsgi.server [req-dfd7458a-1e2d-41d4-b6e1-925174de3d08 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/servers/f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" status: 200 len: 1663 time: 1.0184460 90 2017-06-22 13:41:29.843 4096 INFO nova.osapi_compute.wsgi.server [req-b0c4d0bf-82a5-45bb-8be6-6b3d0d2921ef 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/flavors/1 HTTP/1.1" status: 200 len: 751 time: 0.0990679 91 2017-06-22 13:41:29.923 3958 INFO cinder.volume.flows.manager.create_volume [req-e090c93f-aa81-4a80-b77e-d3072a983248 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Volume 4e248f95-5d7a-4a9d-9675-780acfc5246d: being created as image with specification: {'status': u'creating', 'image_location': (None, None), 'volume_size': 1, 'volume_name': 'volume-4e248f95-5d7a-4a9d-9675-780acfc5246d', 'image_id': 'eb94652f-4764-4ec9-baca-499e181eb91b', 'image_service': <cinder.image.glance.GlanceImageService object at 0x7c4a610>, 'image_meta': {'status': u'active', 'name': u'cirros', 'deleted': False, 'container_format': u'bare', 'created_at': datetime.datetime(2017, 5, 24, 18, 41, 41, tzinfo=<iso8601.Utc>), 'disk_format': u'qcow2', 'updated_at': datetime.datetime(2017, 5, 24, 18, 41, 41, tzinfo=<iso8601.Utc>), 'id': u'eb94652f-4764-4ec9-baca-499e181eb91b', 'owner': u'577fe7d4ac0346a1976335dc7400c65d', 'protected': False, 'min_ram': 0, 'checksum': u'ee1eca47dc88f4879d8a229cc70a07c6', 'min_disk': 0, 'is_public': True, 'deleted_at': None, 'properties': {}, 'size': 13287936}} 92 2017-06-22 13:41:30.198 3958 INFO cinder.image.image_utils [req-e090c93f-aa81-4a80-b77e-d3072a983248 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Image download 12.00 MB at 12.00 MB/s 93 2017-06-22 13:41:30.212 3967 INFO neutron.wsgi [req-03afe1a7-240f-4136-b871-04392df6b536 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:30] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 211 0.360149 94 2017-06-22 13:41:30.303 3967 INFO neutron.wsgi [req-2dde0412-5a6e-4a98-b2c4-7541ece4254f 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:30] "GET /v2.0/floatingips.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 217 0.075354 95 2017-06-22 13:41:30.602 3967 INFO neutron.wsgi [req-7b4aafe4-e9e9-4eb6-bbf4-9d2aa4efb6a5 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:30] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 1014 0.275554 96 2017-06-22 13:41:31.454 3967 INFO neutron.wsgi [req-66c0669a-4938-4a18-a514-73d815103ce3 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:31] "GET /v2.0/networks.json HTTP/1.1" 200 1574 0.843430 97 2017-06-22 13:41:32.704 3967 INFO neutron.wsgi [req-8a609f96-ea5e-4943-a73e-f02b5d0685ce 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:32] "GET /v2.0/subnets.json HTTP/1.1" 200 1509 1.238392 98 2017-06-22 13:41:32.822 3967 INFO neutron.wsgi [req-93608d51-e7a6-4b68-ab2c-1c92f252a36c 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:32] "GET /v2.0/extensions.json HTTP/1.1" 200 7506 0.008408 99 2017-06-22 13:41:33.568 8861 INFO keystone.common.wsgi [req-1f802431-8a24-4181-873e-d2ccf6074767 1f8b1698b91c42169437f856426fc0b1 - - default -] GET http://10.0.2.15:5000/v3/users/1f8b1698b91c42169437f856426fc0b1/projects 100 2017-06-22 13:41:33.800 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[] 101 2017-06-22 13:41:35.973 3967 INFO neutron.wsgi [req-a1b44f80-0cda-4a99-a60c-a20999f5176d 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:41:35] "PUT /v2.0/ports/a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3.json HTTP/1.1" 200 1120 7.069472 102 2017-06-22 13:41:37.197 3967 INFO neutron.wsgi [req-d7fe393f-1dbf-43be-a3d0-b707c756c6cf 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:41:37] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7&device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1123 1.028207 103 2017-06-22 13:41:37.221 3958 INFO cinder.image.image_utils [req-e090c93f-aa81-4a80-b77e-d3072a983248 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Converted 39.00 MB image at 24.02 MB/s 104 2017-06-22 13:41:37.315 3967 INFO neutron.wsgi [req-8f124827-b7c8-4137-9554-7f38fb5d9350 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:41:37] "GET /v2.0/floatingips.json?fixed_ip_address=172.24.4.12&port_id=a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 HTTP/1.1" 200 217 0.061778 105 2017-06-22 13:41:37.710 8860 INFO keystone.common.wsgi [req-81004278-63af-4308-90b7-7757ffd6630e 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 106 2017-06-22 13:41:38.702 3967 INFO neutron.wsgi [req-1fbd363f-5295-4193-bea6-abe57e3b706d 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:38] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1123 1.050775 107 2017-06-22 13:41:39.759 3967 INFO neutron.wsgi [req-0650831a-969b-4983-a584-7a45b136717f 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:41:39] "GET /v2.0/subnets.json?id=c954be37-19a7-4baa-9a57-09e5d9027610 HTTP/1.1" 200 864 2.443404 108 2017-06-22 13:41:39.767 3958 INFO cinder.volume.flows.manager.create_volume [req-e090c93f-aa81-4a80-b77e-d3072a983248 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Volume volume-4e248f95-5d7a-4a9d-9675-780acfc5246d (4e248f95-5d7a-4a9d-9675-780acfc5246d): created successfully 109 2017-06-22 13:41:39.771 3958 INFO cinder.volume.manager [req-e090c93f-aa81-4a80-b77e-d3072a983248 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Created volume successfully. 110 2017-06-22 13:41:40.191 3967 INFO neutron.wsgi [req-bfbc1b6e-3cbc-4bf2-801e-52879c7f9a2b 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:41:40] "GET /v2.0/ports.json?network_id=12f45958-2c36-48bb-ac47-9532ac2d07e4&device_owner=network%3Adhcp HTTP/1.1" 200 211 0.408344 111 2017-06-22 13:41:40.194 3967 INFO neutron.wsgi [req-a49e281a-9749-410c-a40a-db0cd5a9f4f2 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:40] "GET /v2.0/security-groups.json?id=9a1c031e-50c4-4e6e-98bf-52f8cd94f17a HTTP/1.1" 200 2574 1.444873 112 2017-06-22 13:41:40.525 4096 INFO nova.api.openstack.compute.server_external_events [req-fbe9a2a3-a70a-4c5f-a663-8459d8e5c921 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] Creating event network-changed:None for instance f9cc7dc5-949e-467e-b1c5-6453d6e0c47f on localhost.localdomain 113 2017-06-22 13:41:40.578 4096 INFO nova.osapi_compute.wsgi.server [req-c1c844f0-fc92-439a-9827-30ecd7f55fe7 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/servers/f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" status: 200 len: 1705 time: 3.9538350 114 2017-06-22 13:41:40.744 4096 INFO nova.osapi_compute.wsgi.server [req-fbe9a2a3-a70a-4c5f-a663-8459d8e5c921 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] 10.0.2.15 "POST /v2.1/577fe7d4ac0346a1976335dc7400c65d/os-server-external-events HTTP/1.1" status: 200 len: 465 time: 4.7631681 115 2017-06-22 13:41:40.772 4096 INFO nova.osapi_compute.wsgi.server [req-f341ef74-4b55-4319-9e25-c0b53e033c81 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/flavors/1 HTTP/1.1" status: 200 len: 751 time: 0.1510119 116 2017-06-22 13:41:41.584 3967 INFO neutron.notifiers.nova [-] Nova event response: {u'status': u'completed', u'code': 200, u'name': u'network-changed', u'server_uuid': u'f9cc7dc5-949e-467e-b1c5-6453d6e0c47f'} 117 2017-06-22 13:41:42.131 3967 INFO neutron.wsgi [req-0434e009-eb66-4d1e-9a8d-b7a086a66b9a 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:42] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1123 0.546784 118 2017-06-22 13:41:42.134 3967 INFO neutron.wsgi [req-f192d79e-b02f-4d1c-ad4f-7884b7f38259 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:41:42] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7&device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1123 1.403762 119 2017-06-22 13:41:42.426 3967 INFO neutron.wsgi [req-392e08f1-366d-469f-b300-e99902a1d267 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:42] "GET /v2.0/floatingips.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7&port_id=a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 HTTP/1.1" 200 217 0.154877 120 2017-06-22 13:41:43.403 3967 INFO neutron.wsgi [req-58dfcd83-da0e-417d-9fbe-dc47210a3681 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:41:43] "GET /v2.0/networks.json?id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 905 1.238698 121 2017-06-22 13:41:43.586 3967 INFO neutron.wsgi [req-ca073ca3-715c-4422-b3ad-293502a74e33 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:41:43] "GET /v2.0/floatingips.json?fixed_ip_address=172.24.4.12&port_id=a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 HTTP/1.1" 200 217 0.175309 122 2017-06-22 13:41:43.759 3967 INFO neutron.wsgi [req-134e33b5-cebc-4aec-9119-89c6c78bb2d7 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:43] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 1123 1.303612 123 2017-06-22 13:41:44.427 3958 INFO cinder.volume.targets.lio [req-fb004f05-c2f1-4862-a848-93f5a0f9dc07 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Creating iscsi_target for volume: volume-4e248f95-5d7a-4a9d-9675-780acfc5246d 124 2017-06-22 13:41:45.020 3967 INFO neutron.wsgi [req-54e8d1a9-06b0-4134-933b-c79c7b834fbd 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:45] "GET /v2.0/networks.json?id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 905 1.198562 125 2017-06-22 13:41:45.828 3967 INFO neutron.wsgi [req-017b8a05-3746-48cf-bea2-220be353c30d 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:41:45] "GET /v2.0/subnets.json?id=c954be37-19a7-4baa-9a57-09e5d9027610 HTTP/1.1" 200 864 2.212559 126 2017-06-22 13:41:46.213 3967 INFO neutron.wsgi [req-01eeee17-de22-41ce-92b5-8b3033b2adf0 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:41:46] "GET /v2.0/ports.json?network_id=12f45958-2c36-48bb-ac47-9532ac2d07e4&device_owner=network%3Adhcp HTTP/1.1" 200 211 0.347741 127 2017-06-22 13:41:46.386 3967 INFO neutron.wsgi [req-20b7f963-f69b-469a-b622-643172311793 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:46] "GET /v2.0/subnets.json HTTP/1.1" 200 1509 1.341801 128 2017-06-22 13:41:46.544 3967 INFO neutron.wsgi [req-ecee6e5d-391f-4c42-8721-031678400ba8 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:46] "GET /v2.0/extensions.json HTTP/1.1" 200 7506 0.007402 129 2017-06-22 13:41:47.444 8861 INFO keystone.common.wsgi [req-aa956f14-776f-487b-a88b-16c94fb60e7b 1f8b1698b91c42169437f856426fc0b1 - - default -] GET http://10.0.2.15:5000/v3/users/1f8b1698b91c42169437f856426fc0b1/projects 130 2017-06-22 13:41:51.864 3958 INFO cinder.volume.manager [req-fb004f05-c2f1-4862-a848-93f5a0f9dc07 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Initialize volume connection completed successfully. 131 2017-06-22 13:41:52.791 3958 INFO cinder.volume.manager [req-407c52db-4234-4a9d-83ac-d6e2896503ac 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Attaching volume 4e248f95-5d7a-4a9d-9675-780acfc5246d to instance f9cc7dc5-949e-467e-b1c5-6453d6e0c47f at mountpoint /dev/vda on host None. 132 2017-06-22 13:41:53.586 3958 INFO cinder.volume.manager [req-407c52db-4234-4a9d-83ac-d6e2896503ac 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] Attach volume completed successfully. 133 2017-06-22 13:41:53.845 8860 INFO keystone.common.wsgi [req-c1938423-a200-4d2e-bfb3-19aa96dae107 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 134 2017-06-22 13:41:54.121 1578 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 135 2017-06-22 13:41:54.258 3610 WARNING nova.virt.osinfo [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] Cannot find OS information - Reason: (No configuration information found for operating system Empty) 136 2017-06-22 13:41:54.259 3610 INFO nova.virt.libvirt.driver [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Creating image 137 2017-06-22 13:41:54.260 3610 WARNING nova.virt.libvirt.driver [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] File injection into a boot from volume instance is not supported 138 2017-06-22 13:41:54.328 3610 INFO os_brick.initiator.connectors.iscsi [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] Multipath discovery for iSCSI not enabled. 139 2017-06-22 13:41:54.328 3610 INFO os_brick.initiator.connectors.iscsi [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] Trying to connect to iSCSI portal 10.0.2.15:3260 140 2017-06-22 13:41:55.127 3967 INFO neutron.wsgi [req-104bd1fa-92a0-4a91-b705-2752a5380f4d 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:55] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1123 1.318578 141 2017-06-22 13:41:55.194 3610 INFO os_brick.initiator.connectors.iscsi [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] ISCSI volume not yet found at: [u'/dev/disk/by-path/ip-10.0.2.15:3260-iscsi-iqn.2010-10.org.openstack:volume-4e248f95-5d7a-4a9d-9675-780acfc5246d-lun-0']. Will rescan & retry. Try number: 0. 142 2017-06-22 13:41:55.482 3610 WARNING nova.virt.osinfo [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] Cannot find OS information - Reason: (No configuration information found for operating system Empty) 143 2017-06-22 13:41:55.678 3967 INFO neutron.wsgi [req-8f0af6a4-07a3-4cbd-9275-ebd1d4c5946a 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:55] "GET /v2.0/security-groups.json?id=9a1c031e-50c4-4e6e-98bf-52f8cd94f17a HTTP/1.1" 200 2574 0.532723 144 2017-06-22 13:41:55.813 4096 INFO nova.osapi_compute.wsgi.server [req-7f492650-049c-4707-b0e6-a03ad5d34e61 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/servers/f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" status: 200 len: 1876 time: 2.8213012 145 2017-06-22 13:41:55.950 4096 INFO nova.osapi_compute.wsgi.server [req-2080d15e-d1b7-46fa-a9ed-fca65d19c57d 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/flavors/1 HTTP/1.1" status: 200 len: 751 time: 0.1087182 146 2017-06-22 13:41:56.487 3967 INFO neutron.wsgi [req-a471f101-305c-4792-9308-98e65b002ff5 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:56] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1123 0.516389 147 2017-06-22 13:41:56.603 3610 INFO os_vif [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] Successfully plugged vif VIFBridge(active=False,address=fa:16:3e:04:c0:7f,bridge_name='qbra9aa6dee-2b',has_traffic_filtering=True,id=a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3,network=Network(12f45958-2c36-48bb-ac47-9532ac2d07e4),plugin='ovs',port_profile=VIFPortProfileBase,preserve_on_delete=False,vif_name='tapa9aa6dee-2b') 148 2017-06-22 13:41:56.641 3967 INFO neutron.wsgi [req-be5aaf8c-8676-4273-8c40-774a70bdf5a4 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:56] "GET /v2.0/floatingips.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7&port_id=a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 HTTP/1.1" 200 217 0.140998 149 2017-06-22 13:41:57.236 3967 INFO neutron.wsgi [req-2dd9bbce-6fa4-4e67-b9ee-0f08869665e3 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:57] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 1123 0.588325 150 2017-06-22 13:41:57.584 3610 INFO nova.compute.manager [req-05ebca34-8919-4cf9-9f00-7437b35f3f37 - - - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] VM Started (Lifecycle Event) 151 2017-06-22 13:41:57.916 3610 INFO nova.compute.manager [req-05ebca34-8919-4cf9-9f00-7437b35f3f37 - - - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] VM Paused (Lifecycle Event) 152 2017-06-22 13:41:58.270 3967 INFO neutron.wsgi [req-aae77ce6-5798-4001-a15d-5d48a424f361 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:41:58] "GET /v2.0/networks.json?id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 905 1.023021 153 2017-06-22 13:41:58.519 3610 INFO nova.compute.manager [req-05ebca34-8919-4cf9-9f00-7437b35f3f37 - - - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] During sync_power_state the instance has a pending task (spawning). Skip. 154 2017-06-22 13:41:59.183 3640 INFO neutron.plugins.ml2.drivers.openvswitch.agent.ovs_neutron_agent [req-2b5e0b31-d72e-4e73-8aca-e796790e78b3 - - - - -] Port a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 updated. Details: {u'profile': {}, u'network_qos_policy_id': None, u'qos_policy_id': None, u'allowed_address_pairs': [], u'admin_state_up': True, u'network_id': u'12f45958-2c36-48bb-ac47-9532ac2d07e4', u'segmentation_id': None, u'device_owner': u'compute:nova', u'physical_network': u'extnet', u'mac_address': u'fa:16:3e:04:c0:7f', u'device': u'a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3', u'port_security_enabled': True, u'port_id': u'a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3', u'fixed_ips': [{u'subnet_id': u'c954be37-19a7-4baa-9a57-09e5d9027610', u'ip_address': u'172.24.4.12'}], u'network_type': u'flat'} 155 2017-06-22 13:41:59.247 3640 INFO neutron.agent.securitygroups_rpc [req-2b5e0b31-d72e-4e73-8aca-e796790e78b3 - - - - -] Preparing filters for devices set([u'a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3']) 156 2017-06-22 13:42:00.326 3967 INFO neutron.wsgi [req-9adeda45-b6ec-4341-b0fa-5f10e47e7450 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:00] "GET /v2.0/subnets.json HTTP/1.1" 200 1509 2.025177 157 2017-06-22 13:42:00.517 3967 INFO neutron.wsgi [req-bf4da2fe-80e2-46a5-8277-b52df830181f 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:00] "GET /v2.0/extensions.json HTTP/1.1" 200 7506 0.009055 158 2017-06-22 13:42:02.096 4096 INFO nova.osapi_compute.wsgi.server [req-4639fa5a-35ef-4fae-aef8-ad6f3aa913fd 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/extensions HTTP/1.1" status: 200 len: 23035 time: 1.3026631 159 2017-06-22 13:42:02.779 8861 INFO keystone.common.wsgi [req-baf3eacd-2b16-4962-bce2-7bc4c6687aec 1f8b1698b91c42169437f856426fc0b1 - - default -] GET http://10.0.2.15:5000/v3/users/1f8b1698b91c42169437f856426fc0b1/projects 160 2017-06-22 13:42:03.850 3640 INFO neutron.plugins.ml2.drivers.openvswitch.agent.ovs_neutron_agent [req-2b5e0b31-d72e-4e73-8aca-e796790e78b3 - - - - -] Configuration for devices up [u'a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3'] and devices down [] completed. 161 2017-06-22 13:42:03.857 8860 INFO keystone.common.wsgi [req-2a16f9ae-5bc2-48d8-ae10-136eaeea1bde 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 162 2017-06-22 13:42:05.059 4096 INFO nova.api.openstack.compute.server_external_events [req-252a8564-7091-41d2-b9f0-1c807a4974fa 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] Creating event network-vif-plugged:a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 for instance f9cc7dc5-949e-467e-b1c5-6453d6e0c47f on localhost.localdomain 163 2017-06-22 13:42:05.157 3610 INFO nova.compute.manager [req-05ebca34-8919-4cf9-9f00-7437b35f3f37 - - - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] VM Resumed (Lifecycle Event) 164 2017-06-22 13:42:05.188 4096 INFO nova.osapi_compute.wsgi.server [req-252a8564-7091-41d2-b9f0-1c807a4974fa 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] 10.0.2.15 "POST /v2.1/577fe7d4ac0346a1976335dc7400c65d/os-server-external-events HTTP/1.1" status: 200 len: 516 time: 1.4190371 165 2017-06-22 13:42:05.190 3968 INFO neutron.notifiers.nova [-] Nova event response: {u'status': u'completed', u'tag': u'a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3', u'name': u'network-vif-plugged', u'server_uuid': u'f9cc7dc5-949e-467e-b1c5-6453d6e0c47f', u'code': 200} 166 2017-06-22 13:42:05.210 3610 INFO nova.virt.libvirt.driver [-] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Instance spawned successfully. 167 2017-06-22 13:42:05.211 3610 INFO nova.compute.manager [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Took 10.95 seconds to spawn the instance on the hypervisor. 168 2017-06-22 13:42:06.413 3610 INFO nova.compute.manager [req-05ebca34-8919-4cf9-9f00-7437b35f3f37 - - - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] During sync_power_state the instance has a pending task (spawning). Skip. 169 2017-06-22 13:42:06.414 3610 INFO nova.compute.manager [req-05ebca34-8919-4cf9-9f00-7437b35f3f37 - - - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] VM Resumed (Lifecycle Event) 170 2017-06-22 13:42:06.805 1578 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 171 2017-06-22 13:42:07.371 3610 WARNING nova.image.glance [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] No protocol specified in for api_server 'http://10.0.2.15:9292', please update [glance] api_servers with fully qualified url including scheme (http / https) 172 2017-06-22 13:42:07.406 3610 INFO nova.compute.manager [req-b449349a-8bb1-4cc6-8e58-8152ddf08442 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] [instance: f9cc7dc5-949e-467e-b1c5-6453d6e0c47f] Took 48.62 seconds to build instance. 173 2017-06-22 13:42:09.148 21122 INFO keystone.token.persistence.backends.sql [-] Total expired tokens removed: 0 174 2017-06-22 13:42:12.405 3967 INFO neutron.wsgi [req-2ce2dddd-9272-435c-a817-477c5c4ae77a 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:12] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1125 0.642357 175 2017-06-22 13:42:13.032 3967 INFO neutron.wsgi [req-fd179e12-88ef-4233-a0e1-5f1b5685d4b7 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:13] "GET /v2.0/security-groups.json?id=9a1c031e-50c4-4e6e-98bf-52f8cd94f17a HTTP/1.1" 200 2574 0.601075 176 2017-06-22 13:42:13.177 4096 INFO nova.osapi_compute.wsgi.server [req-cb9c4312-eaac-4683-85c5-1d517e007cfe 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/servers/f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" status: 200 len: 1881 time: 2.2076991 177 2017-06-22 13:42:13.384 4096 INFO nova.osapi_compute.wsgi.server [req-39062898-b587-4d59-acf9-6b0d0b69f565 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/flavors/1 HTTP/1.1" status: 200 len: 751 time: 0.1852622 178 2017-06-22 13:42:13.919 3967 INFO neutron.wsgi [req-e3d63a16-af30-4815-b7d1-7a21f329686b 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:13] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1125 0.524591 179 2017-06-22 13:42:14.083 3967 INFO neutron.wsgi [req-f374ecae-ea76-4e92-bb69-d32bfee74ef6 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:14] "GET /v2.0/floatingips.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7&port_id=a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 HTTP/1.1" 200 217 0.149674 180 2017-06-22 13:42:14.603 3967 INFO neutron.wsgi [req-d23ccc21-84c0-44bd-9f65-4072a474e247 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:14] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" 200 1125 0.503394 181 2017-06-22 13:42:15.497 3967 INFO neutron.wsgi [req-4013d63c-975c-4fce-9e25-dcdfe6cca0f5 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:15] "GET /v2.0/networks.json?id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 905 0.879621 182 2017-06-22 13:42:16.360 3967 INFO neutron.wsgi [req-d26d5d8c-fd85-41d5-98a9-b59053ce76ae 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:16] "GET /v2.0/subnets.json HTTP/1.1" 200 1509 0.847605 183 2017-06-22 13:42:16.565 3967 INFO neutron.wsgi [req-8ab7fadf-0a2b-446f-8980-39236e5d686c 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:16] "GET /v2.0/extensions.json HTTP/1.1" 200 7506 0.007995 184 2017-06-22 13:42:17.590 8861 INFO keystone.common.wsgi [req-2bdcb768-d56e-48f6-9193-658a2eb98294 1f8b1698b91c42169437f856426fc0b1 - - default -] GET http://10.0.2.15:5000/v3/users/1f8b1698b91c42169437f856426fc0b1/projects 185 2017-06-22 13:42:33.495 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[] 186 2017-06-22 13:42:38.310 8861 INFO keystone.common.wsgi [req-df3cb997-45c4-47bf-85de-c030c91634f3 - - - - -] GET http://10.0.2.15:5000/v3/ 187 2017-06-22 13:42:38.320 8861 INFO keystone.common.wsgi [req-1ce131ef-9e8b-49d0-aaf7-a38972b98551 - - - - -] POST http://10.0.2.15:5000/v3/auth/tokens 188 2017-06-22 13:42:38.877 8860 INFO keystone.common.wsgi [req-df5c6d50-2d76-4db8-849d-08caa1d4aabf 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 189 2017-06-22 13:42:39.125 4096 INFO nova.osapi_compute.wsgi.server [req-ed0dff61-0de0-4e28-9a78-87eb38a8c162 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7 HTTP/1.1" status: 404 len: 331 time: 0.4401391 190 2017-06-22 13:42:39.148 4096 INFO nova.osapi_compute.wsgi.server [req-9d3b4a69-6f19-467f-996e-04b19ab21470 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/ HTTP/1.1" status: 200 len: 716 time: 0.0126040 191 2017-06-22 13:42:40.011 8860 INFO keystone.common.wsgi [req-602fc345-3e4a-4025-a4c8-ece63e6db80e 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 192 2017-06-22 13:42:40.360 3967 INFO neutron.wsgi [req-cca2ec7b-3531-402e-8caf-3862cee30f07 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:40] "GET /v2.0/ports.json?device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1125 0.552448 193 2017-06-22 13:42:40.486 3967 INFO neutron.wsgi [req-311fefc6-4a3e-4f5c-9b61-50a88a7238b1 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - - -] 10.0.2.15 - - [22/Jun/2017 13:42:40] "GET /v2.0/security-groups.json?id=9a1c031e-50c4-4e6e-98bf-52f8cd94f17a HTTP/1.1" 200 2574 0.116826 194 2017-06-22 13:42:40.527 4096 INFO nova.osapi_compute.wsgi.server [req-82d49ce9-aca9-45f6-8ebc-2d7042c706a0 1f8b1698b91c42169437f856426fc0b1 355c595975894e7d8caa9c3af1ad3cb7 - default default] 10.0.2.15 "GET /v2.1/355c595975894e7d8caa9c3af1ad3cb7/servers/detail HTTP/1.1" status: 200 len: 2259 time: 0.9979980 195 2017-06-22 13:42:52.965 1531 INFO nova.scheduler.host_manager [req-3d4ae2e1-cf88-4656-91ed-4e781b546bbc - - - - -] Successfully synced instances from host 'localhost.localdomain'. 196 2017-06-22 13:42:57.315 3967 INFO neutron.wsgi [req-67005ae8-cb04-4f71-a970-0e7ff6d638c3 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:42:57] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7&device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1125 0.143143 197 2017-06-22 13:42:57.515 3967 INFO neutron.wsgi [req-a2a90ff9-227e-43a1-98b3-9d9ee24b7a23 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:42:57] "GET /v2.0/networks.json?id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 905 0.195707 198 2017-06-22 13:42:57.557 3967 INFO neutron.wsgi [req-b75f3966-3f8c-42aa-b08d-d389bcf67d44 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:42:57] "GET /v2.0/floatingips.json?fixed_ip_address=172.24.4.12&port_id=a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 HTTP/1.1" 200 217 0.031830 199 2017-06-22 13:42:57.800 3967 INFO neutron.wsgi [req-1b8aa004-b26a-4b17-8391-7716243f427a 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:42:57] "GET /v2.0/subnets.json?id=c954be37-19a7-4baa-9a57-09e5d9027610 HTTP/1.1" 200 864 0.237543 200 2017-06-22 13:42:57.880 3967 INFO neutron.wsgi [req-77e98ee7-dfe4-4406-8c9a-9be170a92a70 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:42:57] "GET /v2.0/ports.json?network_id=12f45958-2c36-48bb-ac47-9532ac2d07e4&device_owner=network%3Adhcp HTTP/1.1" 200 211 0.074082 201 2017-06-22 13:43:03.125 21210 INFO keystone.token.persistence.backends.sql [-] Total expired tokens removed: 0 202 2017-06-22 13:43:33.534 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[] 203 2017-06-22 13:43:59.346 3967 INFO neutron.wsgi [req-102d137a-340b-44be-9fd4-6c458d4579c9 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:43:59] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7&device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1125 0.161154 204 2017-06-22 13:43:59.795 3967 INFO neutron.wsgi [req-8bc3fd47-6c0b-478d-97ec-dfd991470919 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:43:59] "GET /v2.0/networks.json?id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 905 0.443032 205 2017-06-22 13:43:59.833 3967 INFO neutron.wsgi [req-bd07894a-c735-488c-95a9-3abe16f58481 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:43:59] "GET /v2.0/floatingips.json?fixed_ip_address=172.24.4.12&port_id=a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 HTTP/1.1" 200 217 0.033398 206 2017-06-22 13:44:00.078 3967 INFO neutron.wsgi [req-0775f61e-146a-4b59-b140-ab949c324a01 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:44:00] "GET /v2.0/subnets.json?id=c954be37-19a7-4baa-9a57-09e5d9027610 HTTP/1.1" 200 864 0.235547 207 2017-06-22 13:44:00.152 3967 INFO neutron.wsgi [req-732541ba-4e5c-4bf6-85d2-7d76da1a8fdb 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:44:00] "GET /v2.0/ports.json?network_id=12f45958-2c36-48bb-ac47-9532ac2d07e4&device_owner=network%3Adhcp HTTP/1.1" 200 211 0.069064 208 2017-06-22 13:44:02.755 21272 INFO keystone.token.persistence.backends.sql [-] Total expired tokens removed: 0 209 2017-06-22 13:44:35.540 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[] 210 2017-06-22 13:44:54.973 1531 INFO nova.scheduler.host_manager [req-bd892d29-3292-4c98-8bf5-91f6711d09c7 - - - - -] Successfully synced instances from host 'localhost.localdomain'. 211 2017-06-22 13:44:59.336 3967 INFO neutron.wsgi [req-4e1d206e-7ef8-4e19-b238-be08999ed2bb 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:44:59] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7&device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1125 0.137660 212 2017-06-22 13:44:59.543 3967 INFO neutron.wsgi [req-be17a957-926d-40e1-833e-ffb9f7a0e14a 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:44:59] "GET /v2.0/networks.json?id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 905 0.200914 213 2017-06-22 13:44:59.582 3967 INFO neutron.wsgi [req-5b64cba2-d12e-4a7d-a694-1883af9f9590 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:44:59] "GET /v2.0/floatingips.json?fixed_ip_address=172.24.4.12&port_id=a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 HTTP/1.1" 200 217 0.033486 214 2017-06-22 13:44:59.813 3967 INFO neutron.wsgi [req-be81eae9-e02e-4526-8b1d-9086bcfbce59 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:44:59] "GET /v2.0/subnets.json?id=c954be37-19a7-4baa-9a57-09e5d9027610 HTTP/1.1" 200 864 0.226248 215 2017-06-22 13:44:59.889 3967 INFO neutron.wsgi [req-2d5281ef-e71d-46de-b4c1-16419198a3d9 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:44:59] "GET /v2.0/ports.json?network_id=12f45958-2c36-48bb-ac47-9532ac2d07e4&device_owner=network%3Adhcp HTTP/1.1" 200 211 0.072366 216 2017-06-22 13:45:03.260 21336 INFO keystone.token.persistence.backends.sql [-] Total expired tokens removed: 0 217 2017-06-22 13:45:37.477 8860 INFO keystone.common.wsgi [req-2c446f3f-335e-4134-8829-881bdb943d9b 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 218 2017-06-22 13:45:37.990 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[] 219 2017-06-22 13:45:59.390 3967 INFO neutron.wsgi [req-e9a61645-b3a0-4ffb-9824-6ca5895ce752 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:45:59] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7&device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1125 0.167390 220 2017-06-22 13:45:59.618 3967 INFO neutron.wsgi [req-e3e4bf21-f5e1-479c-ae14-0097e1ebe472 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:45:59] "GET /v2.0/networks.json?id=12f45958-2c36-48bb-ac47-9532ac2d07e4 HTTP/1.1" 200 905 0.216918 221 2017-06-22 13:45:59.696 3967 INFO neutron.wsgi [req-3efa63e4-23d2-4a43-af51-d81fc7b15d14 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:45:59] "GET /v2.0/floatingips.json?fixed_ip_address=172.24.4.12&port_id=a9aa6dee-2bf1-4e97-a5a2-e5a58e1d57c3 HTTP/1.1" 200 217 0.061589 222 2017-06-22 13:46:00.200 3967 INFO neutron.wsgi [req-5998c261-8537-49f7-b092-3d30e1789f02 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:46:00] "GET /v2.0/subnets.json?id=c954be37-19a7-4baa-9a57-09e5d9027610 HTTP/1.1" 200 864 0.497475 223 2017-06-22 13:46:00.318 3967 INFO neutron.wsgi [req-218919b9-92f4-4b27-8808-ac2fc054fd39 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:46:00] "GET /v2.0/ports.json?network_id=12f45958-2c36-48bb-ac47-9532ac2d07e4&device_owner=network%3Adhcp HTTP/1.1" 200 211 0.106338 224 2017-06-22 13:46:03.250 21400 INFO keystone.token.persistence.backends.sql [-] Total expired tokens removed: 0 225 2017-06-22 13:46:39.556 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[] 226 2017-06-22 13:46:58.958 1531 INFO nova.scheduler.host_manager [req-24938164-1d56-4fcf-9789-6c5b0de1d89c - - - - -] Successfully synced instances from host 'localhost.localdomain'. 227 2017-06-22 13:47:00.395 8860 INFO keystone.common.wsgi [req-fd2725a5-e588-4945-8edd-3b3fff744c28 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 228 2017-06-22 13:47:00.739 3967 INFO neutron.wsgi [req-f11168f6-6c58-4ef4-a120-38fc8bc43ced 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - - -] 10.0.2.15 - - [22/Jun/2017 13:47:00] "GET /v2.0/ports.json?tenant_id=355c595975894e7d8caa9c3af1ad3cb7&device_id=f9cc7dc5-949e-467e-b1c5-6453d6e0c47f HTTP/1.1" 200 1125 0.524100 229 2017-06-22 13:47:03.103 21452 INFO keystone.token.persistence.backends.sql [-] Total expired tokens removed: 0 230 2017-06-22 13:47:41.504 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[] 231 2017-06-22 13:48:03.601 21507 INFO keystone.token.persistence.backends.sql [-] Total expired tokens removed: 0 232 2017-06-22 13:48:29.180 8860 INFO keystone.common.wsgi [req-0a5cb40e-5e1e-4a87-b3ba-1406ef3c85b6 9760566253204a7d8781c22be9ca81d6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 233 2017-06-22 13:48:29.654 8860 INFO keystone.common.wsgi [req-1b0ca127-0cd9-462f-b674-1b1b1fc4aa9f 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 234 2017-06-22 13:48:30.541 8860 INFO keystone.common.wsgi [req-fe68025b-2700-4160-b4fb-b3fe15eabc90 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 235 2017-06-22 13:48:30.893 8860 INFO keystone.common.wsgi [req-3830a5bc-3d2c-4f10-97c9-357f7805af03 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 236 2017-06-22 13:48:31.423 4096 INFO nova.osapi_compute.wsgi.server [req-d0e6ea6c-17fd-4117-aed7-17abf3404a4a e810efa8b27144ff83ec1a9d5788e562 577fe7d4ac0346a1976335dc7400c65d - default default] 10.0.2.15 "GET /v2.1/577fe7d4ac0346a1976335dc7400c65d/servers/detail?all_tenants=True&changes-since=2017-06-22T05%3A38%3A30.625352%2B00%3A00 HTTP/1.1" status: 200 len: 1884 time: 1.9583681 237 2017-06-22 13:48:31.459 8861 INFO keystone.common.wsgi [req-df3cb997-45c4-47bf-85de-c030c91634f3 - - - - -] GET http://10.0.2.15:5000/ 238 2017-06-22 13:48:31.473 8861 INFO keystone.common.wsgi [req-b31ea273-beeb-47e7-8b7b-ec247d18a72a - - - - -] POST http://10.0.2.15:5000/v3/auth/tokens 239 2017-06-22 13:48:31.858 8860 INFO keystone.common.wsgi [req-ecfadf76-fe2d-4dfc-9d0a-15443f57a321 - - - - -] GET http://10.0.2.15:35357/v3/ 240 2017-06-22 13:48:31.881 8860 INFO keystone.common.wsgi [req-52d44e79-d329-4d29-9f2d-55a572ab0281 e810efa8b27144ff83ec1a9d5788e562 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/projects 241 2017-06-22 13:48:32.329 8860 INFO keystone.common.wsgi [req-79d66ab4-b5fb-45c7-b9bd-9b03d034cf5d 525ea601affb42ba82c84fd1ac7f69f6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 242 2017-06-22 13:48:32.377 8860 INFO keystone.common.wsgi [req-8ec7f070-318e-4944-89b1-91024dee19da 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 243 2017-06-22 13:48:33.218 8860 INFO keystone.common.wsgi [req-0c827466-b7b0-4740-aea8-9fe94882bb73 179a265ba71a4d00b602fb130e7fe65b 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens?nocatalog 244 2017-06-22 13:48:33.705 8860 INFO keystone.common.wsgi [req-379b49bd-cde4-43d5-82d3-3fda63afc767 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 245 2017-06-22 13:48:34.234 8860 INFO keystone.common.wsgi [req-76f5caba-8bbf-4932-beed-2920d38a06d6 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 246 2017-06-22 13:48:34.794 4096 INFO nova.osapi_compute.wsgi.server [req-aa5e5918-c0d1-4c53-a08c-dfc78a1ec471 e810efa8b27144ff83ec1a9d5788e562 577fe7d4ac0346a1976335dc7400c65d - default default] 10.0.2.15 "GET /v2.1/577fe7d4ac0346a1976335dc7400c65d/servers/detail?all_tenants=True&changes-since=2017-06-22T05%3A38%3A33.955719%2B00%3A00 HTTP/1.1" status: 200 len: 1884 time: 2.8949311 247 2017-06-22 13:48:35.017 8860 INFO keystone.common.wsgi [req-86007a6e-27d5-43a1-ac9e-c5dc53f1ba22 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 248 2017-06-22 13:48:35.493 8860 INFO keystone.common.wsgi [req-efa18729-8a52-431f-af3d-fcf2e56fc648 9760566253204a7d8781c22be9ca81d6 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 249 2017-06-22 13:48:35.994 8860 INFO keystone.common.wsgi [req-f5c803d7-1e42-49d7-aff8-862133a5e5d6 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 250 2017-06-22 13:48:36.141 8861 INFO keystone.common.wsgi [req-df3cb997-45c4-47bf-85de-c030c91634f3 - - - - -] GET http://10.0.2.15:5000/ 251 2017-06-22 13:48:36.157 8861 INFO keystone.common.wsgi [req-d8f7e9e7-7c77-45bf-9cdb-527defe51a9d - - - - -] POST http://10.0.2.15:5000/v3/auth/tokens 252 2017-06-22 13:48:36.900 8860 INFO keystone.common.wsgi [req-8816c9f6-b4fd-4bc8-b42a-f9a4ca40a374 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 253 2017-06-22 13:48:36.966 8860 INFO keystone.common.wsgi [req-bc22b885-16b4-4ff4-b7ee-0fa0b35787ed - - - - -] GET http://10.0.2.15:35357/v3/ 254 2017-06-22 13:48:37.558 8860 INFO keystone.common.wsgi [req-ac287a16-da55-45a3-85d5-12c0a7f55f8a e810efa8b27144ff83ec1a9d5788e562 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/projects 255 2017-06-22 13:48:38.037 8860 INFO keystone.common.wsgi [req-5ae5588c-3d23-46bf-8c21-fd7afc30a2bc ebd7bc00e2824e2d8b2f45c4d9b737d8 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 256 2017-06-22 13:48:38.150 8860 INFO keystone.common.wsgi [req-4bd54088-6849-404d-84f0-3ab1f3e5aa7c 179a265ba71a4d00b602fb130e7fe65b 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens?nocatalog 257 2017-06-22 13:48:39.130 8860 INFO keystone.common.wsgi [req-6cf89652-8936-43ee-ae76-b3be8bd7623a 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 258 2017-06-22 13:48:39.260 8860 INFO keystone.common.wsgi [req-6d838ac0-0468-42fc-a4b7-7eda30cd503c 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 259 2017-06-22 13:48:40.071 8860 INFO keystone.common.wsgi [req-6809532a-6270-49a7-8fad-26001af24ef5 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 260 2017-06-22 13:48:40.208 8860 INFO keystone.common.wsgi [req-3f967a33-49e1-4346-b54a-068c365bd475 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 261 2017-06-22 13:48:41.057 8860 INFO keystone.common.wsgi [req-6331f24f-e2a7-47aa-b9e0-6e48e0b1d36d 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 262 2017-06-22 13:48:41.157 8860 INFO keystone.common.wsgi [req-4397bc76-bfb2-4059-a96f-57f47340cd4c 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 263 2017-06-22 13:48:41.881 8860 INFO keystone.common.wsgi [req-0cabe704-3b55-4e14-939a-93bfa6d2e5c7 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 264 2017-06-22 13:48:42.090 8860 INFO keystone.common.wsgi [req-94d439ce-2555-42de-9320-d576a51197b3 ebd7bc00e2824e2d8b2f45c4d9b737d8 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 265 2017-06-22 13:48:43.051 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[] 266 2017-06-22 13:48:43.164 8860 INFO keystone.common.wsgi [req-20012d2a-6c77-4b5e-a810-0b72372dca51 ebd7bc00e2824e2d8b2f45c4d9b737d8 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 267 2017-06-22 13:48:43.393 8860 INFO keystone.common.wsgi [req-776f3673-32b1-4e1e-8b20-c886ca0e13f4 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 268 2017-06-22 13:48:44.260 8860 INFO keystone.common.wsgi [req-8c4c43de-8f8f-46ef-a118-e7a96f504195 ebd7bc00e2824e2d8b2f45c4d9b737d8 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 269 2017-06-22 13:48:44.474 8860 INFO keystone.common.wsgi [req-3b304df0-29f2-4261-b65f-aabdf97a44bc 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 270 2017-06-22 13:48:45.398 8860 INFO keystone.common.wsgi [req-aff4d58c-865d-4b07-a6e7-53a12631c132 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 271 2017-06-22 13:48:45.411 8860 INFO keystone.common.wsgi [req-e3924961-5513-4092-89b1-7abe483183a4 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 272 2017-06-22 13:48:46.263 8860 INFO keystone.common.wsgi [req-8aa552f9-aa4c-4adb-b644-3482d2e5b4e8 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 273 2017-06-22 13:48:46.275 8860 INFO keystone.common.wsgi [req-a00811da-d801-43cb-a9be-9b15e379c18b 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 274 2017-06-22 13:48:46.980 8860 INFO keystone.common.wsgi [req-1d66b081-a663-4833-a0b3-1b0554040908 ebd7bc00e2824e2d8b2f45c4d9b737d8 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 275 2017-06-22 13:48:47.597 8860 INFO keystone.common.wsgi [req-c24506b8-3064-4b96-80f5-a5f09757b3b5 ebd7bc00e2824e2d8b2f45c4d9b737d8 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 276 2017-06-22 13:48:48.207 8860 INFO keystone.common.wsgi [req-4a4f4648-2cdc-4e81-a788-148aeb63ed4b 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 277 2017-06-22 13:48:48.667 8860 INFO keystone.common.wsgi [req-ea7abea5-27c1-4395-8b8a-8acb6b9e0d37 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 278 2017-06-22 13:48:49.154 8860 INFO keystone.common.wsgi [req-d7fed59b-fbb8-4373-b0d4-372d882b39c0 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 279 2017-06-22 13:48:49.886 8860 INFO keystone.common.wsgi [req-8fae57da-99f0-44bc-b906-6a0b3ffbdd3d 62e05e7360e347dab374f7e6ecd9373e 577fe7d4ac0346a1976335dc7400c65d - default default] GET http://10.0.2.15:35357/v3/auth/tokens 280 2017-06-22 13:48:59.970 1531 INFO nova.scheduler.host_manager [req-2837eea7-f956-411a-be9a-9194092737a4 - - - - -] Successfully synced instances from host 'localhost.localdomain'. 281 2017-06-22 13:49:03.983 21577 INFO keystone.token.persistence.backends.sql [-] Total expired tokens removed: 0 282 2017-06-22 13:49:44.596 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[] 283 2017-06-22 13:50:46.151 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[] 284 2017-06-22 13:51:03.953 1531 INFO nova.scheduler.host_manager [req-a6a7fc1c-bf22-4222-8cef-8862083587a8 - - - - -] Successfully synced instances from host 'localhost.localdomain'. 285 2017-06-22 13:51:45.558 3610 INFO nova.compute.resource_tracker [req-1b587592-ffe5-4aa0-b635-fb4994ee6eae - - - - -] Final resource view: name=localhost.localdomain phys_ram=7823MB used_ram=1024MB phys_disk=49GB used_disk=1GB total_vcpus=1 used_vcpus=1 pci_stats=[]